[08:31:52.152] New invocation is queued and will start shortly
[08:31:53.332] Starting the invocation (attempt 1)
[08:31:53.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:31:53.388] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:31:53.388] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061805441771054336",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b0a167cea159e3e97c2dc2ad9e361f60a0480e6e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9061805441771054336",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"gitiles_ref:refs/heads/master"
]
}
[08:31:54.664] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574152313668151",
"id": "8896375379501333968",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b0a167cea159e3e97c2dc2ad9e361f60a0480e6e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574152314326795",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25746",
"builder:Deterministic Linux",
"buildset:commit/git/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061805441771054336",
"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/8896375379501333968/+/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": "1574152314326900",
"url": "https://ci.chromium.org/b/8896375379501333968",
"utcnow_ts": "1574152314652899"
}
}
[08:31:54.664] Task URL: https://ci.chromium.org/b/8896375379501333968
[08:31:54.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:2:0) after 1m0s
[08:32:03.451] Received PubSub notification, asking Buildbucket for the build status
[08:32:04.362] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.681] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:2:0)
[08:32:54.681] Timer tick, asking Buildbucket for the build status
[08:32:54.935] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:4:0) after 1m0s
[08:33:55.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:4:0)
[08:33:55.026] Timer tick, asking Buildbucket for the build status
[08:33:56.508] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:56.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:5:0) after 1m0s
[08:34:56.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:5:0)
[08:34:56.532] Timer tick, asking Buildbucket for the build status
[08:34:56.685] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:56.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:6:0) after 1m0s
[08:35:56.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:6:0)
[08:35:56.718] Timer tick, asking Buildbucket for the build status
[08:35:56.897] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:7:0) after 1m0s
[08:36:56.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:7:0)
[08:36:56.895] Timer tick, asking Buildbucket for the build status
[08:36:57.084] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:57.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:8:0) after 1m0s
[08:37:57.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:8:0)
[08:37:57.119] Timer tick, asking Buildbucket for the build status
[08:37:57.684] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:57.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:9:0) after 1m0s
[08:38:57.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:9:0)
[08:38:57.711] Timer tick, asking Buildbucket for the build status
[08:38:58.914] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:58.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:10:0) after 1m0s
[08:39:58.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:10:0)
[08:39:58.991] Timer tick, asking Buildbucket for the build status
[08:39:59.481] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:59.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:11:0) after 1m0s
[08:40:59.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:11:0)
[08:40:59.543] Timer tick, asking Buildbucket for the build status
[08:40:59.816] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:59.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:12:0) after 1m0s
[08:41:59.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:12:0)
[08:41:59.856] Timer tick, asking Buildbucket for the build status
[08:42:00.413] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:00.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:13:0) after 1m0s
[08:43:00.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:13:0)
[08:43:00.479] Timer tick, asking Buildbucket for the build status
[08:43:00.662] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:00.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:14:0) after 1m0s
[08:44:00.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:14:0)
[08:44:00.724] Timer tick, asking Buildbucket for the build status
[08:44:01.326] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:01.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:15:0) after 1m0s
[08:45:01.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:15:0)
[08:45:01.470] Timer tick, asking Buildbucket for the build status
[08:45:02.427] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:02.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:16:0) after 1m0s
[08:46:02.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:16:0)
[08:46:02.467] Timer tick, asking Buildbucket for the build status
[08:46:03.191] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:03.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:17:0) after 1m0s
[08:47:03.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:17:0)
[08:47:03.273] Timer tick, asking Buildbucket for the build status
[08:47:03.466] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:03.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:18:0) after 1m0s
[08:48:03.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:18:0)
[08:48:03.557] Timer tick, asking Buildbucket for the build status
[08:48:03.971] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:03.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:19:0) after 1m0s
[08:49:04.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:19:0)
[08:49:04.025] Timer tick, asking Buildbucket for the build status
[08:49:04.316] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:04.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:20:0) after 1m0s
[08:50:05.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:20:0)
[08:50:05.230] Timer tick, asking Buildbucket for the build status
[08:50:05.408] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:05.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:21:0) after 1m0s
[08:51:05.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:21:0)
[08:51:05.438] Timer tick, asking Buildbucket for the build status
[08:51:06.039] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:06.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:22:0) after 1m0s
[08:52:06.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:22:0)
[08:52:06.124] Timer tick, asking Buildbucket for the build status
[08:52:06.402] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:06.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:23:0) after 1m0s
[08:53:06.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:23:0)
[08:53:06.511] Timer tick, asking Buildbucket for the build status
[08:53:07.015] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:24:0) after 1m0s
[08:54:07.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:24:0)
[08:54:07.105] Timer tick, asking Buildbucket for the build status
[08:54:07.743] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:25:0) after 1m0s
[08:55:07.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:25:0)
[08:55:07.877] Timer tick, asking Buildbucket for the build status
[08:55:08.116] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:08.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:26:0) after 1m0s
[08:56:08.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:26:0)
[08:56:08.166] Timer tick, asking Buildbucket for the build status
[08:56:08.350] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:08.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:27:0) after 1m0s
[08:57:08.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:27:0)
[08:57:08.444] Timer tick, asking Buildbucket for the build status
[08:57:09.120] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:09.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:28:0) after 1m0s
[08:58:09.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:28:0)
[08:58:09.193] Timer tick, asking Buildbucket for the build status
[08:58:09.794] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:09.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:29:0) after 1m0s
[08:59:09.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:29:0)
[08:59:09.803] Timer tick, asking Buildbucket for the build status
[08:59:10.056] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:10.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:30:0) after 1m0s
[09:00:10.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:30:0)
[09:00:10.138] Timer tick, asking Buildbucket for the build status
[09:00:10.393] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:10.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:31:0) after 1m0s
[09:01:10.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:31:0)
[09:01:10.440] Timer tick, asking Buildbucket for the build status
[09:01:10.663] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:10.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:32:0) after 1m0s
[09:02:10.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:32:0)
[09:02:10.718] Timer tick, asking Buildbucket for the build status
[09:02:10.907] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:10.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:33:0) after 1m0s
[09:03:10.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:33:0)
[09:03:10.975] Timer tick, asking Buildbucket for the build status
[09:03:11.548] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:11.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:34:0) after 1m0s
[09:04:11.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:34:0)
[09:04:11.619] Timer tick, asking Buildbucket for the build status
[09:04:11.754] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:11.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:35:0) after 1m0s
[09:05:11.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:35:0)
[09:05:11.750] Timer tick, asking Buildbucket for the build status
[09:05:12.366] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:12.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:36:0) after 1m0s
[09:06:12.377] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:36:0)
[09:06:12.377] Timer tick, asking Buildbucket for the build status
[09:06:13.782] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:13.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:37:0) after 1m0s
[09:07:13.865] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:37:0)
[09:07:13.865] Timer tick, asking Buildbucket for the build status
[09:07:14.144] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:14.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:38:0) after 1m0s
[09:08:14.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:38:0)
[09:08:14.178] Timer tick, asking Buildbucket for the build status
[09:08:14.724] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:14.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:39:0) after 1m0s
[09:09:14.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:39:0)
[09:09:14.734] Timer tick, asking Buildbucket for the build status
[09:09:14.952] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:14.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:40:0) after 1m0s
[09:10:15.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:40:0)
[09:10:15.053] Timer tick, asking Buildbucket for the build status
[09:10:15.775] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:15.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:41:0) after 1m0s
[09:11:15.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:41:0)
[09:11:15.823] Timer tick, asking Buildbucket for the build status
[09:11:16.381] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:16.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:42:0) after 1m0s
[09:12:16.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:42:0)
[09:12:16.537] Timer tick, asking Buildbucket for the build status
[09:12:16.758] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:16.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:43:0) after 1m0s
[09:13:16.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:43:0)
[09:13:16.852] Timer tick, asking Buildbucket for the build status
[09:13:17.231] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:44:0) after 1m0s
[09:14:17.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:44:0)
[09:14:17.294] Timer tick, asking Buildbucket for the build status
[09:14:17.935] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:17.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:45:0) after 1m0s
[09:15:17.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:45:0)
[09:15:17.967] Timer tick, asking Buildbucket for the build status
[09:15:18.505] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:18.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:46:0) after 1m0s
[09:16:18.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:46:0)
[09:16:18.550] Timer tick, asking Buildbucket for the build status
[09:16:18.747] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:18.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:47:0) after 1m0s
[09:17:18.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:47:0)
[09:17:18.904] Timer tick, asking Buildbucket for the build status
[09:17:19.272] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:48:0) after 1m0s
[09:18:19.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:48:0)
[09:18:19.400] Timer tick, asking Buildbucket for the build status
[09:18:19.926] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:49:0) after 1m0s
[09:19:20.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:49:0)
[09:19:20.060] Timer tick, asking Buildbucket for the build status
[09:19:20.313] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:20.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:50:0) after 1m0s
[09:20:20.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:50:0)
[09:20:20.407] Timer tick, asking Buildbucket for the build status
[09:20:20.671] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:20.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:51:0) after 1m0s
[09:21:20.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:51:0)
[09:21:20.696] Timer tick, asking Buildbucket for the build status
[09:21:20.934] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:52:0) after 1m0s
[09:22:20.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:52:0)
[09:22:20.972] Timer tick, asking Buildbucket for the build status
[09:22:21.249] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:21.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:53:0) after 1m0s
[09:23:21.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:53:0)
[09:23:21.416] Timer tick, asking Buildbucket for the build status
[09:23:21.625] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:54:0) after 1m0s
[09:24:21.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:54:0)
[09:24:21.723] Timer tick, asking Buildbucket for the build status
[09:24:22.306] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:22.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:55:0) after 1m0s
[09:25:22.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:55:0)
[09:25:22.336] Timer tick, asking Buildbucket for the build status
[09:25:22.630] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:22.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:56:0) after 1m0s
[09:26:22.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:56:0)
[09:26:22.652] Timer tick, asking Buildbucket for the build status
[09:26:23.359] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:57:0) after 1m0s
[09:27:23.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:57:0)
[09:27:23.395] Timer tick, asking Buildbucket for the build status
[09:27:24.032] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:24.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:58:0) after 1m0s
[09:28:24.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:58:0)
[09:28:24.067] Timer tick, asking Buildbucket for the build status
[09:28:25.017] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:25.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:59:0) after 1m0s
[09:29:25.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:59:0)
[09:29:25.040] Timer tick, asking Buildbucket for the build status
[09:29:25.322] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:25.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:60:0) after 1m0s
[09:30:25.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:60:0)
[09:30:25.351] Timer tick, asking Buildbucket for the build status
[09:30:26.058] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:61:0) after 1m0s
[09:31:26.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:61:0)
[09:31:26.178] Timer tick, asking Buildbucket for the build status
[09:31:26.529] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:26.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:62:0) after 1m0s
[09:32:26.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:62:0)
[09:32:26.607] Timer tick, asking Buildbucket for the build status
[09:32:26.939] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:26.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:63:0) after 1m0s
[09:33:27.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:63:0)
[09:33:27.094] Timer tick, asking Buildbucket for the build status
[09:33:27.445] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:27.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:64:0) after 1m0s
[09:34:27.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:64:0)
[09:34:27.441] Timer tick, asking Buildbucket for the build status
[09:34:27.897] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:27.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:65:0) after 1m0s
[09:35:27.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:65:0)
[09:35:27.901] Timer tick, asking Buildbucket for the build status
[09:35:28.170] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:28.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:66:0) after 1m0s
[09:36:28.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:66:0)
[09:36:28.195] Timer tick, asking Buildbucket for the build status
[09:36:28.642] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:67:0) after 1m0s
[09:37:28.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:67:0)
[09:37:28.711] Timer tick, asking Buildbucket for the build status
[09:37:29.523] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:29.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:68:0) after 1m0s
[09:38:29.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:68:0)
[09:38:29.549] Timer tick, asking Buildbucket for the build status
[09:38:32.221] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:32.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:69:0) after 1m0s
[09:39:32.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:69:0)
[09:39:32.207] Timer tick, asking Buildbucket for the build status
[09:39:32.433] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:32.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:70:0) after 1m0s
[09:40:32.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:70:0)
[09:40:32.501] Timer tick, asking Buildbucket for the build status
[09:40:32.927] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:32.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:71:0) after 1m0s
[09:41:33.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:71:0)
[09:41:33.040] Timer tick, asking Buildbucket for the build status
[09:41:33.598] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:72:0) after 1m0s
[09:42:33.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:72:0)
[09:42:33.724] Timer tick, asking Buildbucket for the build status
[09:42:34.123] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:73:0) after 1m0s
[09:43:34.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:73:0)
[09:43:34.197] Timer tick, asking Buildbucket for the build status
[09:43:34.404] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:34.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:74:0) after 1m0s
[09:44:34.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:74:0)
[09:44:34.425] Timer tick, asking Buildbucket for the build status
[09:44:35.685] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:35.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:75:0) after 1m0s
[09:45:35.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:75:0)
[09:45:35.767] Timer tick, asking Buildbucket for the build status
[09:45:36.311] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:36.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:76:0) after 1m0s
[09:46:36.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:76:0)
[09:46:36.326] Timer tick, asking Buildbucket for the build status
[09:46:36.672] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:36.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:77:0) after 1m0s
[09:47:36.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:77:0)
[09:47:36.876] Timer tick, asking Buildbucket for the build status
[09:47:37.316] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:78:0) after 1m0s
[09:48:37.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:78:0)
[09:48:37.489] Timer tick, asking Buildbucket for the build status
[09:48:38.442] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:79:0) after 1m0s
[09:49:38.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:79:0)
[09:49:38.527] Timer tick, asking Buildbucket for the build status
[09:49:38.676] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:38.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:80:0) after 1m0s
[09:50:38.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:80:0)
[09:50:38.777] Timer tick, asking Buildbucket for the build status
[09:50:39.170] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:39.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:81:0) after 1m0s
[09:51:39.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:81:0)
[09:51:39.292] Timer tick, asking Buildbucket for the build status
[09:51:39.671] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:39.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:82:0) after 1m0s
[09:52:39.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:82:0)
[09:52:39.780] Timer tick, asking Buildbucket for the build status
[09:52:40.008] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:40.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:83:0) after 1m0s
[09:53:40.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:83:0)
[09:53:40.105] Timer tick, asking Buildbucket for the build status
[09:53:40.903] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:40.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:84:0) after 1m0s
[09:54:40.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:84:0)
[09:54:40.987] Timer tick, asking Buildbucket for the build status
[09:54:41.292] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:85:0) after 1m0s
[09:55:41.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:85:0)
[09:55:41.352] Timer tick, asking Buildbucket for the build status
[09:55:42.189] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:42.189] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:86:0) after 1m0s
[09:56:42.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:86:0)
[09:56:42.232] Timer tick, asking Buildbucket for the build status
[09:56:42.407] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:42.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:87:0) after 1m0s
[09:57:42.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:87:0)
[09:57:42.476] Timer tick, asking Buildbucket for the build status
[09:57:43.400] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:43.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:88:0) after 1m0s
[09:58:43.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:88:0)
[09:58:43.489] Timer tick, asking Buildbucket for the build status
[09:58:43.796] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:43.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:89:0) after 1m0s
[09:59:43.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:89:0)
[09:59:43.822] Timer tick, asking Buildbucket for the build status
[09:59:44.101] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:44.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:90:0) after 1m0s
[10:00:44.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:90:0)
[10:00:44.142] Timer tick, asking Buildbucket for the build status
[10:00:44.505] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:44.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:91:0) after 1m0s
[10:01:44.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:91:0)
[10:01:44.570] Timer tick, asking Buildbucket for the build status
[10:01:45.258] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:45.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:92:0) after 1m0s
[10:02:45.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:92:0)
[10:02:45.287] Timer tick, asking Buildbucket for the build status
[10:02:45.778] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:45.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:93:0) after 1m0s
[10:03:45.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:93:0)
[10:03:45.913] Timer tick, asking Buildbucket for the build status
[10:03:46.937] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:46.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:94:0) after 1m0s
[10:04:47.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:94:0)
[10:04:47.041] Timer tick, asking Buildbucket for the build status
[10:04:47.615] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:95:0) after 1m0s
[10:05:47.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:95:0)
[10:05:47.683] Timer tick, asking Buildbucket for the build status
[10:05:49.075] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:49.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:96:0) after 1m0s
[10:06:49.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:96:0)
[10:06:49.106] Timer tick, asking Buildbucket for the build status
[10:06:49.538] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:49.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:97:0) after 1m0s
[10:07:49.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:97:0)
[10:07:49.711] Timer tick, asking Buildbucket for the build status
[10:07:53.064] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:53.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:98:0) after 1m0s
[10:08:53.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:98:0)
[10:08:53.392] Timer tick, asking Buildbucket for the build status
[10:08:53.610] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:53.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:99:0) after 1m0s
[10:09:53.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:99:0)
[10:09:53.911] Timer tick, asking Buildbucket for the build status
[10:09:54.239] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:54.239] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:100:0) after 1m0s
[10:10:54.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:100:0)
[10:10:54.368] Timer tick, asking Buildbucket for the build status
[10:10:54.843] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:54.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:101:0) after 1m0s
[10:11:55.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:101:0)
[10:11:55.018] Timer tick, asking Buildbucket for the build status
[10:11:55.258] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:55.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:102:0) after 1m0s
[10:12:55.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:102:0)
[10:12:55.401] Timer tick, asking Buildbucket for the build status
[10:12:56.914] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:103:0) after 1m0s
[10:13:57.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:103:0)
[10:13:57.180] Timer tick, asking Buildbucket for the build status
[10:13:57.654] Build 8896375379501333968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:57.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061805441771054336:104:0) after 1m0s
[10:14:51.233] Received PubSub notification, asking Buildbucket for the build status
[10:14:51.389] Build 8896375379501333968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:14:51.389] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574158490211369",
"created_by": "project:chromium",
"created_ts": "1574152313668151",
"id": "8896375379501333968",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b0a167cea159e3e97c2dc2ad9e361f60a0480e6e\"}}",
"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-east1-d-8-37-0xld\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25746, \"got_angle_revision\": \"e4b3136913c68b05a84766e8048b28737e9961ee\", \"got_dawn_revision\": \"9c81f8738a47caff631669dba307cc4b2042a7fb\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b0a167cea159e3e97c2dc2ad9e361f60a0480e6e\", \"got_revision_cp\": \"refs/heads/master@{#716540}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"79afb7620a69d0983de8b109837271f7beabe021\", \"got_v8_revision\": \"e1eb815647f334a8cf970439343a8febfa9f6d11\", \"got_v8_revision_cp\": \"refs/heads/8.0.301@{#1}\", \"got_webrtc_revision\": \"aa3f5da8dc014b7ae426396c944217a1cd25b3ae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29821}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b0a167cea159e3e97c2dc2ad9e361f60a0480e6e\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-east1-d-8-37-0xld\"], \"image\": [\"chrome-xenial-19111101-9a63619e779\"], \"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\": [\"4638-f6b223c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574152322462400",
"status": "COMPLETED",
"status_changed_ts": "1574158490737158",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25746",
"builder:Deterministic Linux",
"buildset:commit/git/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0a167cea159e3e97c2dc2ad9e361f60a0480e6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061805441771054336",
"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/8896375379501333968/+/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:489b9bb755060110",
"user_agent:luci-scheduler"
],
"updated_ts": "1574158490757361",
"url": "https://ci.chromium.org/b/8896375379501333968",
"utcnow_ts": "1574158491381693"
}
}
[10:14:51.389] Invocation finished in 1h42m59.269403584s with status SUCCEEDED