[03:29:40.118] New invocation is queued and will start shortly
[03:29:41.216] Starting the invocation (attempt 1)
[03:29:41.280] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:29:41.280] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:29:41.280] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9079400266051378336",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fdbafe78f8468eacf4c86c7ea539769678286d8f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9079400266051378336",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"gitiles_ref:refs/heads/master"
]
}
[03:29:42.689] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557372581500106",
"id": "8913970203939219056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fdbafe78f8468eacf4c86c7ea539769678286d8f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557372582341957",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/22980",
"builder:Deterministic Linux",
"buildset:commit/git/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079400266051378336",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913970203939219056/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1557372582342048",
"url": "https://ci.chromium.org/b/8913970203939219056",
"utcnow_ts": "1557372582672345"
}
}
[03:29:42.689] Task URL: https://ci.chromium.org/b/8913970203939219056
[03:29:42.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:2:0) after 1m0s
[03:29:46.357] Received PubSub notification, asking Buildbucket for the build status
[03:29:47.215] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:42.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:2:0)
[03:30:42.709] Timer tick, asking Buildbucket for the build status
[03:30:43.431] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:43.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:4:0) after 1m0s
[03:31:43.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:4:0)
[03:31:43.418] Timer tick, asking Buildbucket for the build status
[03:31:43.608] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:43.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:5:0) after 1m0s
[03:32:43.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:5:0)
[03:32:43.628] Timer tick, asking Buildbucket for the build status
[03:32:44.403] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:44.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:6:0) after 1m0s
[03:33:44.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:6:0)
[03:33:44.439] Timer tick, asking Buildbucket for the build status
[03:33:44.676] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:44.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:7:0) after 1m0s
[03:34:44.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:7:0)
[03:34:44.657] Timer tick, asking Buildbucket for the build status
[03:34:45.255] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:45.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:8:0) after 1m0s
[03:35:45.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:8:0)
[03:35:45.279] Timer tick, asking Buildbucket for the build status
[03:35:45.451] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:45.451] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:9:0) after 1m0s
[03:36:45.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:9:0)
[03:36:45.487] Timer tick, asking Buildbucket for the build status
[03:36:45.708] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:45.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:10:0) after 1m0s
[03:37:45.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:10:0)
[03:37:45.725] Timer tick, asking Buildbucket for the build status
[03:37:45.833] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:45.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:11:0) after 1m0s
[03:38:45.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:11:0)
[03:38:45.876] Timer tick, asking Buildbucket for the build status
[03:38:46.102] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:46.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:12:0) after 1m0s
[03:39:46.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:12:0)
[03:39:46.437] Timer tick, asking Buildbucket for the build status
[03:39:46.565] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:46.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:13:0) after 1m0s
[03:40:46.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:13:0)
[03:40:46.643] Timer tick, asking Buildbucket for the build status
[03:40:46.987] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:46.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:14:0) after 1m0s
[03:41:46.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:14:0)
[03:41:46.987] Timer tick, asking Buildbucket for the build status
[03:41:47.847] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:47.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:15:0) after 1m0s
[03:42:47.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:15:0)
[03:42:47.875] Timer tick, asking Buildbucket for the build status
[03:42:49.772] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:49.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:16:0) after 1m0s
[03:43:49.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:16:0)
[03:43:49.793] Timer tick, asking Buildbucket for the build status
[03:43:49.942] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:49.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:17:0) after 1m0s
[03:44:49.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:17:0)
[03:44:49.960] Timer tick, asking Buildbucket for the build status
[03:44:50.119] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:50.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:18:0) after 1m0s
[03:45:50.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:18:0)
[03:45:50.105] Timer tick, asking Buildbucket for the build status
[03:45:50.220] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:50.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:19:0) after 1m0s
[03:46:50.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:19:0)
[03:46:50.239] Timer tick, asking Buildbucket for the build status
[03:46:50.774] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:50.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:20:0) after 1m0s
[03:47:50.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:20:0)
[03:47:50.795] Timer tick, asking Buildbucket for the build status
[03:47:50.950] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:50.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:21:0) after 1m0s
[03:48:50.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:21:0)
[03:48:50.971] Timer tick, asking Buildbucket for the build status
[03:48:51.561] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:51.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:22:0) after 1m0s
[03:49:51.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:22:0)
[03:49:51.580] Timer tick, asking Buildbucket for the build status
[03:49:51.680] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:51.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:23:0) after 1m0s
[03:50:51.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:23:0)
[03:50:51.697] Timer tick, asking Buildbucket for the build status
[03:50:51.957] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:51.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:24:0) after 1m0s
[03:51:51.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:24:0)
[03:51:51.977] Timer tick, asking Buildbucket for the build status
[03:51:52.122] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:52.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:25:0) after 1m0s
[03:52:52.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:25:0)
[03:52:52.153] Timer tick, asking Buildbucket for the build status
[03:52:52.372] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:52.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:26:0) after 1m0s
[03:53:52.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:26:0)
[03:53:52.365] Timer tick, asking Buildbucket for the build status
[03:53:53.103] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:53.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:27:0) after 1m0s
[03:54:53.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:27:0)
[03:54:53.085] Timer tick, asking Buildbucket for the build status
[03:54:53.175] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:53.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:28:0) after 1m0s
[03:55:53.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:28:0)
[03:55:53.206] Timer tick, asking Buildbucket for the build status
[03:55:53.595] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:53.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:29:0) after 1m0s
[03:56:53.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:29:0)
[03:56:53.615] Timer tick, asking Buildbucket for the build status
[03:56:53.873] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:53.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:30:0) after 1m0s
[03:57:53.900] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:30:0)
[03:57:53.900] Timer tick, asking Buildbucket for the build status
[03:57:54.010] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:54.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:31:0) after 1m0s
[03:58:54.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:31:0)
[03:58:54.029] Timer tick, asking Buildbucket for the build status
[03:58:54.760] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:54.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:32:0) after 1m0s
[03:59:54.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:32:0)
[03:59:54.790] Timer tick, asking Buildbucket for the build status
[03:59:55.079] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:55.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:33:0) after 1m0s
[04:00:55.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:33:0)
[04:00:55.108] Timer tick, asking Buildbucket for the build status
[04:00:55.774] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:55.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:34:0) after 1m0s
[04:01:55.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:34:0)
[04:01:55.798] Timer tick, asking Buildbucket for the build status
[04:01:56.072] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:56.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:35:0) after 1m0s
[04:02:56.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:35:0)
[04:02:56.063] Timer tick, asking Buildbucket for the build status
[04:02:56.765] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:56.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:36:0) after 1m0s
[04:03:56.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:36:0)
[04:03:56.785] Timer tick, asking Buildbucket for the build status
[04:03:56.876] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:56.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:37:0) after 1m0s
[04:04:56.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:37:0)
[04:04:56.894] Timer tick, asking Buildbucket for the build status
[04:04:56.987] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:56.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:38:0) after 1m0s
[04:05:57.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:38:0)
[04:05:57.015] Timer tick, asking Buildbucket for the build status
[04:05:57.264] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:57.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:39:0) after 1m0s
[04:06:57.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:39:0)
[04:06:57.287] Timer tick, asking Buildbucket for the build status
[04:06:58.620] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:58.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:40:0) after 1m0s
[04:07:58.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:40:0)
[04:07:58.645] Timer tick, asking Buildbucket for the build status
[04:07:58.808] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:58.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:41:0) after 1m0s
[04:08:58.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:41:0)
[04:08:58.829] Timer tick, asking Buildbucket for the build status
[04:08:59.223] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:59.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:42:0) after 1m0s
[04:09:59.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:42:0)
[04:09:59.267] Timer tick, asking Buildbucket for the build status
[04:09:59.687] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:43:0) after 1m0s
[04:10:59.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:43:0)
[04:10:59.694] Timer tick, asking Buildbucket for the build status
[04:11:00.012] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:00.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:44:0) after 1m0s
[04:12:00.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:44:0)
[04:12:00.074] Timer tick, asking Buildbucket for the build status
[04:12:00.900] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:00.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:45:0) after 1m0s
[04:13:00.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:45:0)
[04:13:00.927] Timer tick, asking Buildbucket for the build status
[04:13:01.433] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:01.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:46:0) after 1m0s
[04:14:01.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:46:0)
[04:14:01.459] Timer tick, asking Buildbucket for the build status
[04:14:02.592] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:02.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:47:0) after 1m0s
[04:15:02.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:47:0)
[04:15:02.590] Timer tick, asking Buildbucket for the build status
[04:15:02.863] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:02.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:48:0) after 1m0s
[04:16:02.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:48:0)
[04:16:02.884] Timer tick, asking Buildbucket for the build status
[04:16:03.429] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:03.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:49:0) after 1m0s
[04:17:03.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:49:0)
[04:17:03.455] Timer tick, asking Buildbucket for the build status
[04:17:03.548] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:03.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:50:0) after 1m0s
[04:18:03.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:50:0)
[04:18:03.569] Timer tick, asking Buildbucket for the build status
[04:18:05.809] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:05.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:51:0) after 1m0s
[04:19:05.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:51:0)
[04:19:05.844] Timer tick, asking Buildbucket for the build status
[04:19:06.167] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:06.167] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:52:0) after 1m0s
[04:20:06.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:52:0)
[04:20:06.195] Timer tick, asking Buildbucket for the build status
[04:20:07.080] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:07.080] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:53:0) after 1m0s
[04:21:07.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:53:0)
[04:21:07.075] Timer tick, asking Buildbucket for the build status
[04:21:07.230] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:07.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:54:0) after 1m0s
[04:22:07.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:54:0)
[04:22:07.214] Timer tick, asking Buildbucket for the build status
[04:22:08.259] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:08.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:55:0) after 1m0s
[04:23:08.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:55:0)
[04:23:08.271] Timer tick, asking Buildbucket for the build status
[04:23:08.723] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:08.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:56:0) after 1m0s
[04:24:08.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:56:0)
[04:24:08.711] Timer tick, asking Buildbucket for the build status
[04:24:09.762] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:09.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:57:0) after 1m0s
[04:25:09.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:57:0)
[04:25:09.784] Timer tick, asking Buildbucket for the build status
[04:25:10.488] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:10.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:58:0) after 1m0s
[04:26:10.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:58:0)
[04:26:10.501] Timer tick, asking Buildbucket for the build status
[04:26:10.946] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:10.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:59:0) after 1m0s
[04:27:10.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:59:0)
[04:27:10.966] Timer tick, asking Buildbucket for the build status
[04:27:11.463] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:11.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:60:0) after 1m0s
[04:28:11.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:60:0)
[04:28:11.483] Timer tick, asking Buildbucket for the build status
[04:28:12.859] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:12.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:61:0) after 1m0s
[04:29:12.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:61:0)
[04:29:12.878] Timer tick, asking Buildbucket for the build status
[04:29:12.969] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:12.969] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:62:0) after 1m0s
[04:30:12.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:62:0)
[04:30:12.965] Timer tick, asking Buildbucket for the build status
[04:30:14.532] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:14.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:63:0) after 1m0s
[04:31:14.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:63:0)
[04:31:14.553] Timer tick, asking Buildbucket for the build status
[04:31:14.648] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:14.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:64:0) after 1m0s
[04:32:14.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:64:0)
[04:32:14.667] Timer tick, asking Buildbucket for the build status
[04:32:14.840] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:65:0) after 1m0s
[04:33:14.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:65:0)
[04:33:14.841] Timer tick, asking Buildbucket for the build status
[04:33:15.005] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:15.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:66:0) after 1m0s
[04:34:15.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:66:0)
[04:34:15.015] Timer tick, asking Buildbucket for the build status
[04:34:15.136] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:15.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:67:0) after 1m0s
[04:35:15.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:67:0)
[04:35:15.159] Timer tick, asking Buildbucket for the build status
[04:35:15.692] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:68:0) after 1m0s
[04:36:15.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:68:0)
[04:36:15.700] Timer tick, asking Buildbucket for the build status
[04:36:16.368] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:16.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:69:0) after 1m0s
[04:37:16.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:69:0)
[04:37:16.414] Timer tick, asking Buildbucket for the build status
[04:37:16.519] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:16.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:70:0) after 1m0s
[04:38:16.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:70:0)
[04:38:16.541] Timer tick, asking Buildbucket for the build status
[04:38:16.851] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:16.851] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:71:0) after 1m0s
[04:39:16.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:71:0)
[04:39:16.883] Timer tick, asking Buildbucket for the build status
[04:39:17.190] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:17.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:72:0) after 1m0s
[04:40:17.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:72:0)
[04:40:17.217] Timer tick, asking Buildbucket for the build status
[04:40:17.371] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:17.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:73:0) after 1m0s
[04:41:17.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:73:0)
[04:41:17.467] Timer tick, asking Buildbucket for the build status
[04:41:17.555] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:17.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:74:0) after 1m0s
[04:42:17.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:74:0)
[04:42:17.583] Timer tick, asking Buildbucket for the build status
[04:42:17.776] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:17.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:75:0) after 1m0s
[04:43:17.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:75:0)
[04:43:17.798] Timer tick, asking Buildbucket for the build status
[04:43:17.880] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:17.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:76:0) after 1m0s
[04:44:17.902] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:76:0)
[04:44:17.902] Timer tick, asking Buildbucket for the build status
[04:44:17.991] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:17.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:77:0) after 1m0s
[04:45:18.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:77:0)
[04:45:18.034] Timer tick, asking Buildbucket for the build status
[04:45:18.584] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:18.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:78:0) after 1m0s
[04:46:18.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:78:0)
[04:46:18.609] Timer tick, asking Buildbucket for the build status
[04:46:20.207] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:20.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:79:0) after 1m0s
[04:47:20.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:79:0)
[04:47:20.232] Timer tick, asking Buildbucket for the build status
[04:47:21.716] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:21.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:80:0) after 1m0s
[04:48:21.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:80:0)
[04:48:21.741] Timer tick, asking Buildbucket for the build status
[04:48:22.317] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:22.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:81:0) after 1m0s
[04:49:22.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:81:0)
[04:49:22.333] Timer tick, asking Buildbucket for the build status
[04:49:22.594] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:22.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:82:0) after 1m0s
[04:50:22.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:82:0)
[04:50:22.617] Timer tick, asking Buildbucket for the build status
[04:50:23.028] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:23.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:83:0) after 1m0s
[04:51:23.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:83:0)
[04:51:23.033] Timer tick, asking Buildbucket for the build status
[04:51:23.144] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:23.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:84:0) after 1m0s
[04:52:23.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:84:0)
[04:52:23.176] Timer tick, asking Buildbucket for the build status
[04:52:24.342] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:24.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:85:0) after 1m0s
[04:53:24.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:85:0)
[04:53:24.367] Timer tick, asking Buildbucket for the build status
[04:53:25.300] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:25.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:86:0) after 1m0s
[04:54:25.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:86:0)
[04:54:25.333] Timer tick, asking Buildbucket for the build status
[04:54:25.610] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:25.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:87:0) after 1m0s
[04:55:25.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:87:0)
[04:55:25.692] Timer tick, asking Buildbucket for the build status
[04:55:25.837] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:25.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:88:0) after 1m0s
[04:56:25.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:88:0)
[04:56:25.861] Timer tick, asking Buildbucket for the build status
[04:56:26.484] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:26.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:89:0) after 1m0s
[04:57:26.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:89:0)
[04:57:26.518] Timer tick, asking Buildbucket for the build status
[04:57:26.611] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:26.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:90:0) after 1m0s
[04:58:26.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:90:0)
[04:58:26.633] Timer tick, asking Buildbucket for the build status
[04:58:26.953] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:26.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:91:0) after 1m0s
[04:59:26.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:91:0)
[04:59:26.955] Timer tick, asking Buildbucket for the build status
[04:59:27.154] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:27.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:92:0) after 1m0s
[05:00:27.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:92:0)
[05:00:27.157] Timer tick, asking Buildbucket for the build status
[05:00:27.498] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:93:0) after 1m0s
[05:01:27.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:93:0)
[05:01:27.527] Timer tick, asking Buildbucket for the build status
[05:01:28.085] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:28.085] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:94:0) after 1m0s
[05:02:28.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:94:0)
[05:02:28.352] Timer tick, asking Buildbucket for the build status
[05:02:28.697] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:28.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:95:0) after 1m0s
[05:03:28.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:95:0)
[05:03:28.724] Timer tick, asking Buildbucket for the build status
[05:03:28.969] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:28.969] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:96:0) after 1m0s
[05:04:28.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:96:0)
[05:04:28.988] Timer tick, asking Buildbucket for the build status
[05:04:29.923] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:29.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:97:0) after 1m0s
[05:05:29.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:97:0)
[05:05:29.952] Timer tick, asking Buildbucket for the build status
[05:05:30.466] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:98:0) after 1m0s
[05:06:30.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:98:0)
[05:06:30.543] Timer tick, asking Buildbucket for the build status
[05:06:30.642] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:30.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:99:0) after 1m0s
[05:07:30.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:99:0)
[05:07:30.684] Timer tick, asking Buildbucket for the build status
[05:07:30.956] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:30.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:100:0) after 1m0s
[05:08:30.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:100:0)
[05:08:30.975] Timer tick, asking Buildbucket for the build status
[05:08:31.875] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:31.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:101:0) after 1m0s
[05:09:31.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:101:0)
[05:09:31.901] Timer tick, asking Buildbucket for the build status
[05:09:32.019] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:32.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:102:0) after 1m0s
[05:10:32.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:102:0)
[05:10:32.041] Timer tick, asking Buildbucket for the build status
[05:10:33.205] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:33.205] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:103:0) after 1m0s
[05:11:33.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:103:0)
[05:11:33.198] Timer tick, asking Buildbucket for the build status
[05:11:34.880] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:34.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:104:0) after 1m0s
[05:12:34.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:104:0)
[05:12:34.887] Timer tick, asking Buildbucket for the build status
[05:12:34.981] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:34.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:105:0) after 1m0s
[05:13:35.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:105:0)
[05:13:35.011] Timer tick, asking Buildbucket for the build status
[05:13:35.875] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:35.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:106:0) after 1m0s
[05:14:35.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:106:0)
[05:14:35.903] Timer tick, asking Buildbucket for the build status
[05:14:36.196] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:36.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:107:0) after 1m0s
[05:15:36.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:107:0)
[05:15:36.229] Timer tick, asking Buildbucket for the build status
[05:15:36.392] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:36.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:108:0) after 1m0s
[05:16:36.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:108:0)
[05:16:36.388] Timer tick, asking Buildbucket for the build status
[05:16:37.759] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:37.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:109:0) after 1m0s
[05:17:37.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:109:0)
[05:17:37.736] Timer tick, asking Buildbucket for the build status
[05:17:38.249] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:38.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:110:0) after 1m0s
[05:18:38.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:110:0)
[05:18:38.276] Timer tick, asking Buildbucket for the build status
[05:18:38.878] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:38.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:111:0) after 1m0s
[05:19:38.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:111:0)
[05:19:38.867] Timer tick, asking Buildbucket for the build status
[05:19:39.373] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:112:0) after 1m0s
[05:20:39.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:112:0)
[05:20:39.402] Timer tick, asking Buildbucket for the build status
[05:20:39.496] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:39.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:113:0) after 1m0s
[05:21:39.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:113:0)
[05:21:39.528] Timer tick, asking Buildbucket for the build status
[05:21:39.651] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:114:0) after 1m0s
[05:22:39.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:114:0)
[05:22:39.622] Timer tick, asking Buildbucket for the build status
[05:22:40.368] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:40.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:115:0) after 1m0s
[05:23:40.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:115:0)
[05:23:40.383] Timer tick, asking Buildbucket for the build status
[05:23:40.962] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:40.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:116:0) after 1m0s
[05:24:40.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:116:0)
[05:24:40.999] Timer tick, asking Buildbucket for the build status
[05:24:41.291] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:41.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:117:0) after 1m0s
[05:25:41.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:117:0)
[05:25:41.316] Timer tick, asking Buildbucket for the build status
[05:25:42.166] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:42.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:118:0) after 1m0s
[05:26:42.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:118:0)
[05:26:42.214] Timer tick, asking Buildbucket for the build status
[05:26:42.481] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:42.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:119:0) after 1m0s
[05:27:42.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:119:0)
[05:27:42.492] Timer tick, asking Buildbucket for the build status
[05:27:42.899] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:120:0) after 1m0s
[05:28:42.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:120:0)
[05:28:42.943] Timer tick, asking Buildbucket for the build status
[05:28:43.095] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:43.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:121:0) after 1m0s
[05:29:43.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:121:0)
[05:29:43.087] Timer tick, asking Buildbucket for the build status
[05:29:43.257] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:43.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:122:0) after 1m0s
[05:30:43.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:122:0)
[05:30:43.268] Timer tick, asking Buildbucket for the build status
[05:30:43.674] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:43.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:123:0) after 1m0s
[05:31:43.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:123:0)
[05:31:43.660] Timer tick, asking Buildbucket for the build status
[05:31:44.142] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:44.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:124:0) after 1m0s
[05:32:44.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:124:0)
[05:32:44.168] Timer tick, asking Buildbucket for the build status
[05:32:44.472] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:44.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:125:0) after 1m0s
[05:33:44.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:125:0)
[05:33:44.519] Timer tick, asking Buildbucket for the build status
[05:33:47.494] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:47.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:126:0) after 1m0s
[05:34:47.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:126:0)
[05:34:47.520] Timer tick, asking Buildbucket for the build status
[05:34:47.807] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:47.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:127:0) after 1m0s
[05:35:47.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:127:0)
[05:35:47.831] Timer tick, asking Buildbucket for the build status
[05:35:48.652] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:48.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:128:0) after 1m0s
[05:36:48.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:128:0)
[05:36:48.632] Timer tick, asking Buildbucket for the build status
[05:36:50.385] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:129:0) after 1m0s
[05:37:50.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:129:0)
[05:37:50.411] Timer tick, asking Buildbucket for the build status
[05:37:50.646] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:50.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:130:0) after 1m0s
[05:38:50.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:130:0)
[05:38:50.692] Timer tick, asking Buildbucket for the build status
[05:38:51.449] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:51.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:131:0) after 1m0s
[05:39:51.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:131:0)
[05:39:51.446] Timer tick, asking Buildbucket for the build status
[05:39:51.769] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:51.769] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:132:0) after 1m0s
[05:40:51.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:132:0)
[05:40:51.812] Timer tick, asking Buildbucket for the build status
[05:40:52.339] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:52.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:133:0) after 1m0s
[05:41:52.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:133:0)
[05:41:52.378] Timer tick, asking Buildbucket for the build status
[05:41:52.858] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:134:0) after 1m0s
[05:42:52.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:134:0)
[05:42:52.929] Timer tick, asking Buildbucket for the build status
[05:42:53.069] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:53.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:135:0) after 1m0s
[05:43:53.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:135:0)
[05:43:53.086] Timer tick, asking Buildbucket for the build status
[05:43:53.577] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:53.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:136:0) after 1m0s
[05:44:53.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:136:0)
[05:44:53.658] Timer tick, asking Buildbucket for the build status
[05:44:53.952] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:53.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:137:0) after 1m0s
[05:45:53.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:137:0)
[05:45:53.980] Timer tick, asking Buildbucket for the build status
[05:45:54.162] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:54.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:138:0) after 1m0s
[05:46:54.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:138:0)
[05:46:54.209] Timer tick, asking Buildbucket for the build status
[05:46:54.298] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:139:0) after 1m0s
[05:47:54.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:139:0)
[05:47:54.333] Timer tick, asking Buildbucket for the build status
[05:47:54.589] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:54.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:140:0) after 1m0s
[05:48:54.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:140:0)
[05:48:54.596] Timer tick, asking Buildbucket for the build status
[05:48:55.245] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:55.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:141:0) after 1m0s
[05:49:55.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:141:0)
[05:49:55.246] Timer tick, asking Buildbucket for the build status
[05:49:55.655] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:55.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:142:0) after 1m0s
[05:50:55.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:142:0)
[05:50:55.808] Timer tick, asking Buildbucket for the build status
[05:50:55.974] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:55.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:143:0) after 1m0s
[05:51:55.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:143:0)
[05:51:55.998] Timer tick, asking Buildbucket for the build status
[05:51:56.293] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:56.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:144:0) after 1m0s
[05:52:56.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:144:0)
[05:52:56.320] Timer tick, asking Buildbucket for the build status
[05:52:56.409] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:56.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:145:0) after 1m0s
[05:53:56.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:145:0)
[05:53:56.433] Timer tick, asking Buildbucket for the build status
[05:53:56.630] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:56.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:146:0) after 1m0s
[05:54:56.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:146:0)
[05:54:56.612] Timer tick, asking Buildbucket for the build status
[05:54:56.854] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:56.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:147:0) after 1m0s
[05:55:56.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:147:0)
[05:55:56.878] Timer tick, asking Buildbucket for the build status
[05:55:57.384] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:57.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:148:0) after 1m0s
[05:56:57.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:148:0)
[05:56:57.403] Timer tick, asking Buildbucket for the build status
[05:56:57.578] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:57.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:149:0) after 1m0s
[05:57:57.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:149:0)
[05:57:57.582] Timer tick, asking Buildbucket for the build status
[05:57:58.153] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:58.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:150:0) after 1m0s
[05:58:58.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:150:0)
[05:58:58.136] Timer tick, asking Buildbucket for the build status
[05:58:58.226] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:151:0) after 1m0s
[05:59:58.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:151:0)
[05:59:58.258] Timer tick, asking Buildbucket for the build status
[05:59:58.406] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:58.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:152:0) after 1m0s
[06:00:58.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:152:0)
[06:00:58.432] Timer tick, asking Buildbucket for the build status
[06:00:58.611] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:58.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:153:0) after 1m0s
[06:01:58.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:153:0)
[06:01:58.638] Timer tick, asking Buildbucket for the build status
[06:01:59.015] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:59.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:154:0) after 1m0s
[06:02:59.020] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:154:0)
[06:02:59.020] Timer tick, asking Buildbucket for the build status
[06:02:59.155] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:59.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:155:0) after 1m0s
[06:03:59.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:155:0)
[06:03:59.137] Timer tick, asking Buildbucket for the build status
[06:03:59.243] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:59.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:156:0) after 1m0s
[06:04:59.270] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:156:0)
[06:04:59.270] Timer tick, asking Buildbucket for the build status
[06:04:59.976] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:59.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:157:0) after 1m0s
[06:05:59.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:157:0)
[06:05:59.966] Timer tick, asking Buildbucket for the build status
[06:06:02.820] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:02.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:158:0) after 1m0s
[06:07:02.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:158:0)
[06:07:02.821] Timer tick, asking Buildbucket for the build status
[06:07:03.396] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:03.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:159:0) after 1m0s
[06:08:03.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:159:0)
[06:08:03.421] Timer tick, asking Buildbucket for the build status
[06:08:03.509] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:03.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:160:0) after 1m0s
[06:09:03.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:160:0)
[06:09:03.501] Timer tick, asking Buildbucket for the build status
[06:09:03.998] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:03.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:161:0) after 1m0s
[06:10:04.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:161:0)
[06:10:04.066] Timer tick, asking Buildbucket for the build status
[06:10:07.153] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:07.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:162:0) after 1m0s
[06:11:07.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:162:0)
[06:11:07.212] Timer tick, asking Buildbucket for the build status
[06:11:07.987] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:07.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:163:0) after 1m0s
[06:12:08.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:163:0)
[06:12:08.025] Timer tick, asking Buildbucket for the build status
[06:12:08.189] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:08.189] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:164:0) after 1m0s
[06:13:08.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:164:0)
[06:13:08.169] Timer tick, asking Buildbucket for the build status
[06:13:08.868] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:08.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:165:0) after 1m0s
[06:14:08.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:165:0)
[06:14:08.879] Timer tick, asking Buildbucket for the build status
[06:14:09.223] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:09.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:166:0) after 1m0s
[06:15:09.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:166:0)
[06:15:09.256] Timer tick, asking Buildbucket for the build status
[06:15:09.749] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:09.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:167:0) after 1m0s
[06:16:09.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:167:0)
[06:16:09.832] Timer tick, asking Buildbucket for the build status
[06:16:10.001] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:10.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:168:0) after 1m0s
[06:17:10.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:168:0)
[06:17:10.029] Timer tick, asking Buildbucket for the build status
[06:17:10.666] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:10.666] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:169:0) after 1m0s
[06:18:10.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:169:0)
[06:18:10.699] Timer tick, asking Buildbucket for the build status
[06:18:10.929] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:10.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:170:0) after 1m0s
[06:19:10.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:170:0)
[06:19:10.959] Timer tick, asking Buildbucket for the build status
[06:19:11.251] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:171:0) after 1m0s
[06:20:11.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:171:0)
[06:20:11.280] Timer tick, asking Buildbucket for the build status
[06:20:11.381] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:11.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:172:0) after 1m0s
[06:21:11.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:172:0)
[06:21:11.380] Timer tick, asking Buildbucket for the build status
[06:21:11.780] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:11.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:173:0) after 1m0s
[06:22:11.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:173:0)
[06:22:11.781] Timer tick, asking Buildbucket for the build status
[06:22:12.133] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:12.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:174:0) after 1m0s
[06:23:12.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:174:0)
[06:23:12.125] Timer tick, asking Buildbucket for the build status
[06:23:12.873] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:175:0) after 1m0s
[06:24:13.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:175:0)
[06:24:13.034] Timer tick, asking Buildbucket for the build status
[06:24:13.134] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:13.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:176:0) after 1m0s
[06:25:13.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:176:0)
[06:25:13.184] Timer tick, asking Buildbucket for the build status
[06:25:13.459] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:13.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:177:0) after 1m0s
[06:26:13.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:177:0)
[06:26:13.452] Timer tick, asking Buildbucket for the build status
[06:26:13.733] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:178:0) after 1m0s
[06:27:13.773] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:178:0)
[06:27:13.773] Timer tick, asking Buildbucket for the build status
[06:27:13.934] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:13.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:179:0) after 1m0s
[06:28:13.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:179:0)
[06:28:13.914] Timer tick, asking Buildbucket for the build status
[06:28:14.028] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:14.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:180:0) after 1m0s
[06:29:14.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:180:0)
[06:29:14.126] Timer tick, asking Buildbucket for the build status
[06:29:14.419] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:14.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:181:0) after 1m0s
[06:30:14.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:181:0)
[06:30:14.453] Timer tick, asking Buildbucket for the build status
[06:30:14.534] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:182:0) after 1m0s
[06:31:14.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:182:0)
[06:31:14.540] Timer tick, asking Buildbucket for the build status
[06:31:14.656] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:14.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:183:0) after 1m0s
[06:32:14.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:183:0)
[06:32:14.702] Timer tick, asking Buildbucket for the build status
[06:32:14.964] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:14.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:184:0) after 1m0s
[06:33:14.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:184:0)
[06:33:14.990] Timer tick, asking Buildbucket for the build status
[06:33:15.321] Build 8913970203939219056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:15.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9079400266051378336:185:0) after 1m0s
[06:33:17.456] Received PubSub notification, asking Buildbucket for the build status
[06:33:18.068] Build 8913970203939219056: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[06:33:18.068] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1557383596714113",
"created_by": "project:chromium",
"created_ts": "1557372581500106",
"id": "8913970203939219056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fdbafe78f8468eacf4c86c7ea539769678286d8f\"}}",
"project": "chromium",
"result": "CANCELED",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"gce-trusty-e833d7b0-us-west1-b-n1mg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 22980, \"got_angle_revision\": \"a10b2d078ceb55cc1ba1bf6d7558095154f24163\", \"got_dawn_revision\": \"974a1503273543719df2a3a18a967a4a785d49f1\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"fdbafe78f8468eacf4c86c7ea539769678286d8f\", \"got_revision_cp\": \"refs/heads/master@{#657995}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"aa52ef3fa846058455b64a82627cc9945e01381d\", \"got_v8_revision_cp\": \"refs/heads/7.6.128@{#1}\", \"got_webrtc_revision\": \"d8b9ed77cf5263616703cc9fc159361e64222093\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27879}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fdbafe78f8468eacf4c86c7ea539769678286d8f\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Deterministic Linux\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-n1mg\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4291-fed3552\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557372585322199",
"status": "COMPLETED",
"status_changed_ts": "1557383596997203",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/22980",
"builder:Deterministic Linux",
"buildset:commit/git/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdbafe78f8468eacf4c86c7ea539769678286d8f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079400266051378336",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913970203939219056/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:44b3754408419a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1557383596999381",
"url": "https://ci.chromium.org/b/8913970203939219056",
"utcnow_ts": "1557383597998357"
}
}
[06:33:18.068] Invocation finished in 3h3m37.966209151s with status FAILED