[04:25:55.032] New invocation is queued and will start shortly
[04:25:56.186] Starting the invocation (attempt 1)
[04:25:56.248] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:25:56.248] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:25:56.248] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056838082563935168",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2dc3ddd6eca48dfeb7176a3a159737e602b2d333\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9056838082563935168",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"gitiles_ref:refs/heads/master"
]
}
[04:25:57.284] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578889556445902",
"id": "8891408020419147040",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2dc3ddd6eca48dfeb7176a3a159737e602b2d333\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578889557086677",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26446",
"builder:Deterministic Linux",
"buildset:commit/git/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056838082563935168",
"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/8891408020419147040/+/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": "1578889557086842",
"url": "https://ci.chromium.org/b/8891408020419147040",
"utcnow_ts": "1578889557273879"
}
}
[04:25:57.284] Task URL: https://ci.chromium.org/b/8891408020419147040
[04:25:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:2:0) after 1m0s
[04:26:36.472] Received PubSub notification, asking Buildbucket for the build status
[04:26:36.637] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:57.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:2:0)
[04:26:57.297] Timer tick, asking Buildbucket for the build status
[04:26:57.526] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:57.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:4:0) after 1m0s
[04:27:57.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:4:0)
[04:27:57.553] Timer tick, asking Buildbucket for the build status
[04:27:58.661] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:58.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:5:0) after 1m0s
[04:28:58.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:5:0)
[04:28:58.693] Timer tick, asking Buildbucket for the build status
[04:28:59.163] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:59.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:6:0) after 1m0s
[04:29:59.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:6:0)
[04:29:59.203] Timer tick, asking Buildbucket for the build status
[04:29:59.657] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:59.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:7:0) after 1m0s
[04:30:59.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:7:0)
[04:30:59.712] Timer tick, asking Buildbucket for the build status
[04:30:59.885] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:59.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:8:0) after 1m0s
[04:31:59.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:8:0)
[04:31:59.905] Timer tick, asking Buildbucket for the build status
[04:32:00.102] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:00.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:9:0) after 1m0s
[04:33:00.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:9:0)
[04:33:00.198] Timer tick, asking Buildbucket for the build status
[04:33:00.357] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:00.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:10:0) after 1m0s
[04:34:00.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:10:0)
[04:34:00.389] Timer tick, asking Buildbucket for the build status
[04:34:00.764] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:00.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:11:0) after 1m0s
[04:35:01.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:11:0)
[04:35:01.013] Timer tick, asking Buildbucket for the build status
[04:35:01.279] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:01.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:12:0) after 1m0s
[04:36:01.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:12:0)
[04:36:01.408] Timer tick, asking Buildbucket for the build status
[04:36:01.742] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:01.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:13:0) after 1m0s
[04:37:01.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:13:0)
[04:37:01.798] Timer tick, asking Buildbucket for the build status
[04:37:01.991] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:01.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:14:0) after 1m0s
[04:38:02.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:14:0)
[04:38:02.052] Timer tick, asking Buildbucket for the build status
[04:38:02.360] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:02.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:15:0) after 1m0s
[04:39:02.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:15:0)
[04:39:02.435] Timer tick, asking Buildbucket for the build status
[04:39:02.747] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:02.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:16:0) after 1m0s
[04:40:02.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:16:0)
[04:40:02.837] Timer tick, asking Buildbucket for the build status
[04:40:02.976] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:02.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:17:0) after 1m0s
[04:41:02.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:17:0)
[04:41:02.989] Timer tick, asking Buildbucket for the build status
[04:41:03.387] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:03.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:18:0) after 1m0s
[04:42:03.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:18:0)
[04:42:03.480] Timer tick, asking Buildbucket for the build status
[04:42:03.714] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:03.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:19:0) after 1m0s
[04:43:03.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:19:0)
[04:43:03.790] Timer tick, asking Buildbucket for the build status
[04:43:03.981] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:03.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:20:0) after 1m0s
[04:44:03.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:20:0)
[04:44:03.991] Timer tick, asking Buildbucket for the build status
[04:44:04.534] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:04.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:21:0) after 1m0s
[04:45:04.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:21:0)
[04:45:04.570] Timer tick, asking Buildbucket for the build status
[04:45:04.880] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:04.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:22:0) after 1m0s
[04:46:05.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:22:0)
[04:46:05.056] Timer tick, asking Buildbucket for the build status
[04:46:05.347] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:05.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:23:0) after 1m0s
[04:47:05.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:23:0)
[04:47:05.366] Timer tick, asking Buildbucket for the build status
[04:47:05.591] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:05.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:24:0) after 1m0s
[04:48:05.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:24:0)
[04:48:05.665] Timer tick, asking Buildbucket for the build status
[04:48:05.888] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:05.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:25:0) after 1m0s
[04:49:05.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:25:0)
[04:49:05.925] Timer tick, asking Buildbucket for the build status
[04:49:07.290] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:07.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:26:0) after 1m0s
[04:50:07.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:26:0)
[04:50:07.271] Timer tick, asking Buildbucket for the build status
[04:50:07.422] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:07.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:27:0) after 1m0s
[04:51:07.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:27:0)
[04:51:07.454] Timer tick, asking Buildbucket for the build status
[04:51:07.689] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:07.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:28:0) after 1m0s
[04:52:07.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:28:0)
[04:52:07.709] Timer tick, asking Buildbucket for the build status
[04:52:07.937] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:07.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:29:0) after 1m0s
[04:53:07.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:29:0)
[04:53:07.964] Timer tick, asking Buildbucket for the build status
[04:53:08.187] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:08.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:30:0) after 1m0s
[04:54:08.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:30:0)
[04:54:08.215] Timer tick, asking Buildbucket for the build status
[04:54:08.348] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:31:0) after 1m0s
[04:55:08.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:31:0)
[04:55:08.384] Timer tick, asking Buildbucket for the build status
[04:55:09.124] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:09.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:32:0) after 1m0s
[04:56:09.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:32:0)
[04:56:09.148] Timer tick, asking Buildbucket for the build status
[04:56:09.484] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:09.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:33:0) after 1m0s
[04:57:09.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:33:0)
[04:57:09.544] Timer tick, asking Buildbucket for the build status
[04:57:09.849] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:09.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:34:0) after 1m0s
[04:58:09.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:34:0)
[04:58:09.874] Timer tick, asking Buildbucket for the build status
[04:58:10.095] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:10.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:35:0) after 1m0s
[04:59:10.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:35:0)
[04:59:10.186] Timer tick, asking Buildbucket for the build status
[04:59:11.150] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:11.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:36:0) after 1m0s
[05:00:11.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:36:0)
[05:00:11.229] Timer tick, asking Buildbucket for the build status
[05:00:11.404] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:11.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:37:0) after 1m0s
[05:01:11.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:37:0)
[05:01:11.427] Timer tick, asking Buildbucket for the build status
[05:01:11.692] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:11.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:38:0) after 1m0s
[05:02:11.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:38:0)
[05:02:11.713] Timer tick, asking Buildbucket for the build status
[05:02:17.201] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:17.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:39:0) after 1m0s
[05:03:17.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:39:0)
[05:03:17.218] Timer tick, asking Buildbucket for the build status
[05:03:17.382] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:17.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:40:0) after 1m0s
[05:04:17.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:40:0)
[05:04:17.410] Timer tick, asking Buildbucket for the build status
[05:04:17.596] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:17.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:41:0) after 1m0s
[05:05:17.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:41:0)
[05:05:17.668] Timer tick, asking Buildbucket for the build status
[05:05:18.453] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:18.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:42:0) after 1m0s
[05:06:18.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:42:0)
[05:06:18.572] Timer tick, asking Buildbucket for the build status
[05:06:18.900] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:18.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:43:0) after 1m0s
[05:07:19.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:43:0)
[05:07:19.026] Timer tick, asking Buildbucket for the build status
[05:07:19.216] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:19.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:44:0) after 1m0s
[05:08:19.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:44:0)
[05:08:19.238] Timer tick, asking Buildbucket for the build status
[05:08:19.662] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:19.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:45:0) after 1m0s
[05:09:19.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:45:0)
[05:09:19.690] Timer tick, asking Buildbucket for the build status
[05:09:19.936] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:19.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:46:0) after 1m0s
[05:10:19.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:46:0)
[05:10:19.957] Timer tick, asking Buildbucket for the build status
[05:10:20.249] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:20.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:47:0) after 1m0s
[05:11:20.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:47:0)
[05:11:20.285] Timer tick, asking Buildbucket for the build status
[05:11:20.512] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:20.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:48:0) after 1m0s
[05:12:20.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:48:0)
[05:12:20.491] Timer tick, asking Buildbucket for the build status
[05:12:20.646] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:20.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:49:0) after 1m0s
[05:13:20.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:49:0)
[05:13:20.694] Timer tick, asking Buildbucket for the build status
[05:13:20.847] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:20.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:50:0) after 1m0s
[05:14:20.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:50:0)
[05:14:20.868] Timer tick, asking Buildbucket for the build status
[05:14:21.164] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:21.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:51:0) after 1m0s
[05:15:21.150] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:51:0)
[05:15:21.150] Timer tick, asking Buildbucket for the build status
[05:15:21.476] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:21.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:52:0) after 1m0s
[05:16:21.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:52:0)
[05:16:21.504] Timer tick, asking Buildbucket for the build status
[05:16:21.663] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:53:0) after 1m0s
[05:17:21.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:53:0)
[05:17:21.687] Timer tick, asking Buildbucket for the build status
[05:17:21.845] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:21.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:54:0) after 1m0s
[05:18:21.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:54:0)
[05:18:21.887] Timer tick, asking Buildbucket for the build status
[05:18:22.653] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:22.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:55:0) after 1m0s
[05:19:22.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:55:0)
[05:19:22.722] Timer tick, asking Buildbucket for the build status
[05:19:23.374] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:23.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:56:0) after 1m0s
[05:20:23.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:56:0)
[05:20:23.486] Timer tick, asking Buildbucket for the build status
[05:20:24.343] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:24.343] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:57:0) after 1m0s
[05:21:24.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:57:0)
[05:21:24.468] Timer tick, asking Buildbucket for the build status
[05:21:25.509] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:25.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:58:0) after 1m0s
[05:22:25.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:58:0)
[05:22:25.538] Timer tick, asking Buildbucket for the build status
[05:22:26.183] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:26.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:59:0) after 1m0s
[05:23:26.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:59:0)
[05:23:26.390] Timer tick, asking Buildbucket for the build status
[05:23:26.590] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:26.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:60:0) after 1m0s
[05:24:26.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:60:0)
[05:24:26.737] Timer tick, asking Buildbucket for the build status
[05:24:26.959] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:26.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:61:0) after 1m0s
[05:25:27.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:61:0)
[05:25:27.016] Timer tick, asking Buildbucket for the build status
[05:25:27.780] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:27.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:62:0) after 1m0s
[05:26:27.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:62:0)
[05:26:27.854] Timer tick, asking Buildbucket for the build status
[05:26:28.802] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:28.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:63:0) after 1m0s
[05:27:28.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:63:0)
[05:27:28.858] Timer tick, asking Buildbucket for the build status
[05:27:29.603] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:29.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:64:0) after 1m0s
[05:28:29.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:64:0)
[05:28:29.658] Timer tick, asking Buildbucket for the build status
[05:28:29.863] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:29.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:65:0) after 1m0s
[05:29:29.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:65:0)
[05:29:29.845] Timer tick, asking Buildbucket for the build status
[05:29:29.998] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:29.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:66:0) after 1m0s
[05:30:30.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:66:0)
[05:30:30.028] Timer tick, asking Buildbucket for the build status
[05:30:30.263] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:30.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:67:0) after 1m0s
[05:31:30.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:67:0)
[05:31:30.346] Timer tick, asking Buildbucket for the build status
[05:31:30.548] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:30.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:68:0) after 1m0s
[05:32:30.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:68:0)
[05:32:30.590] Timer tick, asking Buildbucket for the build status
[05:32:30.763] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:30.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:69:0) after 1m0s
[05:33:30.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:69:0)
[05:33:30.818] Timer tick, asking Buildbucket for the build status
[05:33:31.671] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:31.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:70:0) after 1m0s
[05:34:31.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:70:0)
[05:34:31.792] Timer tick, asking Buildbucket for the build status
[05:34:32.218] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:71:0) after 1m0s
[05:35:32.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:71:0)
[05:35:32.300] Timer tick, asking Buildbucket for the build status
[05:35:33.163] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:33.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:72:0) after 1m0s
[05:36:33.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:72:0)
[05:36:33.172] Timer tick, asking Buildbucket for the build status
[05:36:33.463] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:33.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:73:0) after 1m0s
[05:37:33.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:73:0)
[05:37:33.700] Timer tick, asking Buildbucket for the build status
[05:37:34.571] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:34.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:74:0) after 1m0s
[05:38:34.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:74:0)
[05:38:34.711] Timer tick, asking Buildbucket for the build status
[05:38:34.896] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:34.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:75:0) after 1m0s
[05:39:35.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:75:0)
[05:39:35.128] Timer tick, asking Buildbucket for the build status
[05:39:35.308] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:35.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:76:0) after 1m0s
[05:40:35.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:76:0)
[05:40:35.506] Timer tick, asking Buildbucket for the build status
[05:40:35.659] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:35.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:77:0) after 1m0s
[05:41:35.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:77:0)
[05:41:35.863] Timer tick, asking Buildbucket for the build status
[05:41:36.588] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:36.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:78:0) after 1m0s
[05:42:36.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:78:0)
[05:42:36.815] Timer tick, asking Buildbucket for the build status
[05:42:37.027] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:37.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:79:0) after 1m0s
[05:43:37.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:79:0)
[05:43:37.091] Timer tick, asking Buildbucket for the build status
[05:43:37.251] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:37.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:80:0) after 1m0s
[05:44:37.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:80:0)
[05:44:37.462] Timer tick, asking Buildbucket for the build status
[05:44:37.698] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:37.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:81:0) after 1m0s
[05:45:37.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:81:0)
[05:45:37.761] Timer tick, asking Buildbucket for the build status
[05:45:38.365] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:82:0) after 1m0s
[05:46:38.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:82:0)
[05:46:38.335] Timer tick, asking Buildbucket for the build status
[05:46:38.900] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:83:0) after 1m0s
[05:47:39.020] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:83:0)
[05:47:39.020] Timer tick, asking Buildbucket for the build status
[05:47:39.231] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:39.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:84:0) after 1m0s
[05:48:39.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:84:0)
[05:48:39.333] Timer tick, asking Buildbucket for the build status
[05:48:39.527] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:39.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:85:0) after 1m0s
[05:49:40.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:85:0)
[05:49:40.111] Timer tick, asking Buildbucket for the build status
[05:49:40.448] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:40.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:86:0) after 1m0s
[05:50:40.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:86:0)
[05:50:40.626] Timer tick, asking Buildbucket for the build status
[05:50:40.914] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:40.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:87:0) after 1m0s
[05:51:41.120] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:87:0)
[05:51:41.120] Timer tick, asking Buildbucket for the build status
[05:51:41.882] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:88:0) after 1m0s
[05:52:42.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:88:0)
[05:52:42.179] Timer tick, asking Buildbucket for the build status
[05:52:42.410] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:42.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:89:0) after 1m0s
[05:53:42.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:89:0)
[05:53:42.718] Timer tick, asking Buildbucket for the build status
[05:53:43.197] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:43.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:90:0) after 1m0s
[05:54:43.227] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:90:0)
[05:54:43.227] Timer tick, asking Buildbucket for the build status
[05:54:44.138] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:44.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:91:0) after 1m0s
[05:55:44.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:91:0)
[05:55:44.162] Timer tick, asking Buildbucket for the build status
[05:55:44.949] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:44.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:92:0) after 1m0s
[05:56:45.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:92:0)
[05:56:45.122] Timer tick, asking Buildbucket for the build status
[05:56:45.371] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:45.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:93:0) after 1m0s
[05:57:45.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:93:0)
[05:57:45.399] Timer tick, asking Buildbucket for the build status
[05:57:45.961] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:45.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:94:0) after 1m0s
[05:58:46.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:94:0)
[05:58:46.212] Timer tick, asking Buildbucket for the build status
[05:58:46.446] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:46.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:95:0) after 1m0s
[05:59:46.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:95:0)
[05:59:46.540] Timer tick, asking Buildbucket for the build status
[05:59:46.712] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:46.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:96:0) after 1m0s
[06:00:46.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:96:0)
[06:00:46.893] Timer tick, asking Buildbucket for the build status
[06:00:47.357] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:47.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:97:0) after 1m0s
[06:01:47.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:97:0)
[06:01:47.398] Timer tick, asking Buildbucket for the build status
[06:01:47.588] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:47.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:98:0) after 1m0s
[06:02:47.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:98:0)
[06:02:47.837] Timer tick, asking Buildbucket for the build status
[06:02:48.267] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:48.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:99:0) after 1m0s
[06:03:48.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:99:0)
[06:03:48.408] Timer tick, asking Buildbucket for the build status
[06:03:48.606] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:48.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:100:0) after 1m0s
[06:04:48.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:100:0)
[06:04:48.631] Timer tick, asking Buildbucket for the build status
[06:04:49.067] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:101:0) after 1m0s
[06:05:49.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:101:0)
[06:05:49.144] Timer tick, asking Buildbucket for the build status
[06:05:49.516] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:102:0) after 1m0s
[06:06:49.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:102:0)
[06:06:49.735] Timer tick, asking Buildbucket for the build status
[06:06:49.934] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:49.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:103:0) after 1m0s
[06:07:49.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:103:0)
[06:07:49.985] Timer tick, asking Buildbucket for the build status
[06:07:50.531] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:50.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:104:0) after 1m0s
[06:08:50.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:104:0)
[06:08:50.584] Timer tick, asking Buildbucket for the build status
[06:08:54.489] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:54.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:105:0) after 1m0s
[06:09:54.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:105:0)
[06:09:54.542] Timer tick, asking Buildbucket for the build status
[06:09:54.816] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:54.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:106:0) after 1m0s
[06:10:54.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:106:0)
[06:10:54.967] Timer tick, asking Buildbucket for the build status
[06:10:55.737] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:55.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:107:0) after 1m0s
[06:11:55.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:107:0)
[06:11:55.805] Timer tick, asking Buildbucket for the build status
[06:11:56.540] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:56.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:108:0) after 1m0s
[06:12:56.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:108:0)
[06:12:56.665] Timer tick, asking Buildbucket for the build status
[06:12:57.237] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:57.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:109:0) after 1m0s
[06:13:57.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:109:0)
[06:13:57.265] Timer tick, asking Buildbucket for the build status
[06:13:57.522] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:57.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:110:0) after 1m0s
[06:14:57.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:110:0)
[06:14:57.600] Timer tick, asking Buildbucket for the build status
[06:14:57.903] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:57.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:111:0) after 1m0s
[06:15:57.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:111:0)
[06:15:57.999] Timer tick, asking Buildbucket for the build status
[06:15:58.191] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:58.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:112:0) after 1m0s
[06:16:58.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:112:0)
[06:16:58.356] Timer tick, asking Buildbucket for the build status
[06:16:58.741] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:58.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:113:0) after 1m0s
[06:17:58.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:113:0)
[06:17:58.872] Timer tick, asking Buildbucket for the build status
[06:17:59.307] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:59.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:114:0) after 1m0s
[06:18:59.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:114:0)
[06:18:59.477] Timer tick, asking Buildbucket for the build status
[06:18:59.817] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:59.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:115:0) after 1m0s
[06:19:59.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:115:0)
[06:19:59.888] Timer tick, asking Buildbucket for the build status
[06:20:00.134] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:00.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:116:0) after 1m0s
[06:21:00.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:116:0)
[06:21:00.337] Timer tick, asking Buildbucket for the build status
[06:21:01.004] Build 8891408020419147040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:01.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056838082563935168:117:0) after 1m0s
[06:21:46.425] Received PubSub notification, asking Buildbucket for the build status
[06:21:46.811] Build 8891408020419147040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:21:46.811] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578896505365822",
"created_by": "project:chromium",
"created_ts": "1578889556445902",
"id": "8891408020419147040",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2dc3ddd6eca48dfeb7176a3a159737e602b2d333\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"luci-chromium-ci-xenial-us-central1-b-8-112-bf60\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26446, \"got_angle_revision\": \"ed074852bf075546232c438cd095a1845462ff40\", \"got_dawn_revision\": \"69c68d01b2420e77283166ffcc7ddb4b0fbc2505\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"2dc3ddd6eca48dfeb7176a3a159737e602b2d333\", \"got_revision_cp\": \"refs/heads/master@{#730467}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b0ca2a89e255446237d92ffbd76ef3bf97bfd6cd\", \"got_v8_revision\": \"6a92d23c36e0a21638b808f49b33c6aefe46313d\", \"got_v8_revision_cp\": \"refs/heads/8.1.159@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2dc3ddd6eca48dfeb7176a3a159737e602b2d333\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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\": [\"luci-chromium-ci-xenial-us-central1-b-8-112-bf60\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4752-73c7603\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578889595661375",
"status": "COMPLETED",
"status_changed_ts": "1578896506056993",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26446",
"builder:Deterministic Linux",
"buildset:commit/git/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2dc3ddd6eca48dfeb7176a3a159737e602b2d333",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056838082563935168",
"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/8891408020419147040/+/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:49b5f83d76e35210",
"user_agent:luci-scheduler"
],
"updated_ts": "1578896506060660",
"url": "https://ci.chromium.org/b/8891408020419147040",
"utcnow_ts": "1578896506760946"
}
}
[06:21:46.811] Invocation finished in 1h55m51.795826033s with status SUCCEEDED