[23:35:48.605] New invocation is queued and will start shortly
[23:35:49.947] Starting the invocation (attempt 1)
[23:35:50.030] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:35:50.030] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:35:50.033] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056675140594235696",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1cf1a551c9899a92cd49754913eda8ea9a3b249b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9056675140594235696",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"gitiles_ref:refs/heads/master"
]
}
[23:35:51.363] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579044950590818",
"id": "8891245077848884496",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1cf1a551c9899a92cd49754913eda8ea9a3b249b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579044951102459",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26469",
"builder:Deterministic Linux",
"buildset:commit/git/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056675140594235696",
"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/8891245077848884496/+/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": "1579044951102646",
"url": "https://ci.chromium.org/b/8891245077848884496",
"utcnow_ts": "1579044951342782"
}
}
[23:35:51.363] Task URL: https://ci.chromium.org/b/8891245077848884496
[23:35:51.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:2:0) after 1m0s
[23:36:41.515] Received PubSub notification, asking Buildbucket for the build status
[23:36:42.802] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:51.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:2:0)
[23:36:51.376] Timer tick, asking Buildbucket for the build status
[23:36:51.647] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:51.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:4:0) after 1m0s
[23:37:51.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:4:0)
[23:37:51.751] Timer tick, asking Buildbucket for the build status
[23:37:53.017] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:53.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:5:0) after 1m0s
[23:38:53.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:5:0)
[23:38:53.036] Timer tick, asking Buildbucket for the build status
[23:38:53.257] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:53.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:6:0) after 1m0s
[23:39:53.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:6:0)
[23:39:53.314] Timer tick, asking Buildbucket for the build status
[23:39:53.855] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:53.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:7:0) after 1m0s
[23:40:53.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:7:0)
[23:40:53.941] Timer tick, asking Buildbucket for the build status
[23:40:55.305] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:55.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:8:0) after 1m0s
[23:41:55.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:8:0)
[23:41:55.346] Timer tick, asking Buildbucket for the build status
[23:41:55.518] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:55.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:9:0) after 1m0s
[23:42:55.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:9:0)
[23:42:55.631] Timer tick, asking Buildbucket for the build status
[23:42:55.852] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:55.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:10:0) after 1m0s
[23:43:55.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:10:0)
[23:43:55.909] Timer tick, asking Buildbucket for the build status
[23:43:56.044] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:11:0) after 1m0s
[23:44:56.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:11:0)
[23:44:56.115] Timer tick, asking Buildbucket for the build status
[23:44:56.364] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:56.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:12:0) after 1m0s
[23:45:56.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:12:0)
[23:45:56.457] Timer tick, asking Buildbucket for the build status
[23:45:56.874] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:56.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:13:0) after 1m0s
[23:46:57.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:13:0)
[23:46:57.029] Timer tick, asking Buildbucket for the build status
[23:46:57.901] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:57.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:14:0) after 1m0s
[23:47:57.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:14:0)
[23:47:57.983] Timer tick, asking Buildbucket for the build status
[23:47:58.302] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:15:0) after 1m0s
[23:48:58.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:15:0)
[23:48:58.374] Timer tick, asking Buildbucket for the build status
[23:48:59.266] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:59.266] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:16:0) after 1m0s
[23:49:59.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:16:0)
[23:49:59.289] Timer tick, asking Buildbucket for the build status
[23:50:00.474] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:00.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:17:0) after 1m0s
[23:51:00.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:17:0)
[23:51:00.538] Timer tick, asking Buildbucket for the build status
[23:51:00.694] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:00.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:18:0) after 1m0s
[23:52:00.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:18:0)
[23:52:00.778] Timer tick, asking Buildbucket for the build status
[23:52:00.965] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:00.965] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:19:0) after 1m0s
[23:53:00.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:19:0)
[23:53:00.987] Timer tick, asking Buildbucket for the build status
[23:53:01.641] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:01.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:20:0) after 1m0s
[23:54:01.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:20:0)
[23:54:01.720] Timer tick, asking Buildbucket for the build status
[23:54:02.015] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:02.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:21:0) after 1m0s
[23:55:02.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:21:0)
[23:55:02.156] Timer tick, asking Buildbucket for the build status
[23:55:03.283] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:03.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:22:0) after 1m0s
[23:56:03.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:22:0)
[23:56:03.269] Timer tick, asking Buildbucket for the build status
[23:56:03.401] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:03.401] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:23:0) after 1m0s
[23:57:03.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:23:0)
[23:57:03.497] Timer tick, asking Buildbucket for the build status
[23:57:03.671] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:03.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:24:0) after 1m0s
[23:58:03.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:24:0)
[23:58:03.833] Timer tick, asking Buildbucket for the build status
[23:58:04.058] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:04.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:25:0) after 1m0s
[23:59:04.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:25:0)
[23:59:04.275] Timer tick, asking Buildbucket for the build status
[23:59:04.543] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:04.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:26:0) after 1m0s
[00:00:04.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:26:0)
[00:00:04.733] Timer tick, asking Buildbucket for the build status
[00:00:04.934] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:04.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:27:0) after 1m0s
[00:01:05.325] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:27:0)
[00:01:05.325] Timer tick, asking Buildbucket for the build status
[00:01:05.738] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:05.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:28:0) after 1m0s
[00:02:05.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:28:0)
[00:02:05.983] Timer tick, asking Buildbucket for the build status
[00:02:06.199] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:06.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:29:0) after 1m0s
[00:03:06.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:29:0)
[00:03:06.522] Timer tick, asking Buildbucket for the build status
[00:03:06.673] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:06.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:30:0) after 1m0s
[00:04:06.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:30:0)
[00:04:06.693] Timer tick, asking Buildbucket for the build status
[00:04:06.819] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:06.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:31:0) after 1m0s
[00:05:07.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:31:0)
[00:05:07.129] Timer tick, asking Buildbucket for the build status
[00:05:07.366] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:07.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:32:0) after 1m0s
[00:06:07.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:32:0)
[00:06:07.465] Timer tick, asking Buildbucket for the build status
[00:06:07.794] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:07.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:33:0) after 1m0s
[00:07:07.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:33:0)
[00:07:07.927] Timer tick, asking Buildbucket for the build status
[00:07:08.132] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:08.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:34:0) after 1m0s
[00:08:08.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:34:0)
[00:08:08.277] Timer tick, asking Buildbucket for the build status
[00:08:08.894] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:35:0) after 1m0s
[00:09:08.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:35:0)
[00:09:08.986] Timer tick, asking Buildbucket for the build status
[00:09:09.588] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:09.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:36:0) after 1m0s
[00:10:09.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:36:0)
[00:10:09.770] Timer tick, asking Buildbucket for the build status
[00:10:10.119] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:10.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:37:0) after 1m0s
[00:11:10.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:37:0)
[00:11:10.148] Timer tick, asking Buildbucket for the build status
[00:11:11.207] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:11.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:38:0) after 1m0s
[00:12:11.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:38:0)
[00:12:11.213] Timer tick, asking Buildbucket for the build status
[00:12:11.984] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:11.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:39:0) after 1m0s
[00:13:12.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:39:0)
[00:13:12.072] Timer tick, asking Buildbucket for the build status
[00:13:12.268] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:40:0) after 1m0s
[00:14:12.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:40:0)
[00:14:12.283] Timer tick, asking Buildbucket for the build status
[00:14:12.515] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:12.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:41:0) after 1m0s
[00:15:12.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:41:0)
[00:15:12.750] Timer tick, asking Buildbucket for the build status
[00:15:12.904] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:12.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:42:0) after 1m0s
[00:16:13.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:42:0)
[00:16:13.001] Timer tick, asking Buildbucket for the build status
[00:16:14.158] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:14.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:43:0) after 1m0s
[00:17:14.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:43:0)
[00:17:14.181] Timer tick, asking Buildbucket for the build status
[00:17:14.509] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:14.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:44:0) after 1m0s
[00:18:14.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:44:0)
[00:18:14.532] Timer tick, asking Buildbucket for the build status
[00:18:14.840] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:45:0) after 1m0s
[00:19:14.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:45:0)
[00:19:14.886] Timer tick, asking Buildbucket for the build status
[00:19:15.044] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:46:0) after 1m0s
[00:20:15.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:46:0)
[00:20:15.133] Timer tick, asking Buildbucket for the build status
[00:20:15.819] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:15.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:47:0) after 1m0s
[00:21:15.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:47:0)
[00:21:15.857] Timer tick, asking Buildbucket for the build status
[00:21:17.895] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:17.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:48:0) after 1m0s
[00:22:17.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:48:0)
[00:22:17.930] Timer tick, asking Buildbucket for the build status
[00:22:18.118] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:18.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:49:0) after 1m0s
[00:23:18.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:49:0)
[00:23:18.202] Timer tick, asking Buildbucket for the build status
[00:23:19.597] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:19.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:50:0) after 1m0s
[00:24:19.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:50:0)
[00:24:19.619] Timer tick, asking Buildbucket for the build status
[00:24:19.753] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:19.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:51:0) after 1m0s
[00:25:19.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:51:0)
[00:25:19.780] Timer tick, asking Buildbucket for the build status
[00:25:20.179] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:20.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:52:0) after 1m0s
[00:26:20.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:52:0)
[00:26:20.287] Timer tick, asking Buildbucket for the build status
[00:26:20.437] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:20.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:53:0) after 1m0s
[00:27:20.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:53:0)
[00:27:20.564] Timer tick, asking Buildbucket for the build status
[00:27:20.885] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:20.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:54:0) after 1m0s
[00:28:20.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:54:0)
[00:28:20.924] Timer tick, asking Buildbucket for the build status
[00:28:21.555] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:21.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:55:0) after 1m0s
[00:29:21.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:55:0)
[00:29:21.609] Timer tick, asking Buildbucket for the build status
[00:29:21.823] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:21.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:56:0) after 1m0s
[00:30:21.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:56:0)
[00:30:21.898] Timer tick, asking Buildbucket for the build status
[00:30:24.113] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:24.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:57:0) after 1m0s
[00:31:24.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:57:0)
[00:31:24.189] Timer tick, asking Buildbucket for the build status
[00:31:25.756] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:25.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:58:0) after 1m0s
[00:32:25.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:58:0)
[00:32:25.832] Timer tick, asking Buildbucket for the build status
[00:32:26.604] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:26.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:59:0) after 1m0s
[00:33:26.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:59:0)
[00:33:26.655] Timer tick, asking Buildbucket for the build status
[00:33:26.834] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:26.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:60:0) after 1m0s
[00:34:26.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:60:0)
[00:34:26.948] Timer tick, asking Buildbucket for the build status
[00:34:27.366] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:27.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:61:0) after 1m0s
[00:35:27.426] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:61:0)
[00:35:27.427] Timer tick, asking Buildbucket for the build status
[00:35:27.873] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:62:0) after 1m0s
[00:36:27.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:62:0)
[00:36:27.957] Timer tick, asking Buildbucket for the build status
[00:36:28.114] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:28.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:63:0) after 1m0s
[00:37:28.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:63:0)
[00:37:28.193] Timer tick, asking Buildbucket for the build status
[00:37:28.668] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:28.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:64:0) after 1m0s
[00:38:28.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:64:0)
[00:38:28.688] Timer tick, asking Buildbucket for the build status
[00:38:29.079] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:29.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:65:0) after 1m0s
[00:39:29.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:65:0)
[00:39:29.146] Timer tick, asking Buildbucket for the build status
[00:39:29.695] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:66:0) after 1m0s
[00:40:29.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:66:0)
[00:40:29.774] Timer tick, asking Buildbucket for the build status
[00:40:30.045] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:30.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:67:0) after 1m0s
[00:41:30.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:67:0)
[00:41:30.167] Timer tick, asking Buildbucket for the build status
[00:41:31.155] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:31.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:68:0) after 1m0s
[00:42:31.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:68:0)
[00:42:31.217] Timer tick, asking Buildbucket for the build status
[00:42:31.762] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:31.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:69:0) after 1m0s
[00:43:31.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:69:0)
[00:43:31.848] Timer tick, asking Buildbucket for the build status
[00:43:32.065] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:32.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:70:0) after 1m0s
[00:44:32.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:70:0)
[00:44:32.093] Timer tick, asking Buildbucket for the build status
[00:44:33.930] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:33.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:71:0) after 1m0s
[00:45:34.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:71:0)
[00:45:34.125] Timer tick, asking Buildbucket for the build status
[00:45:34.245] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:34.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:72:0) after 1m0s
[00:46:34.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:72:0)
[00:46:34.305] Timer tick, asking Buildbucket for the build status
[00:46:34.496] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:34.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:73:0) after 1m0s
[00:47:34.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:73:0)
[00:47:34.523] Timer tick, asking Buildbucket for the build status
[00:47:34.751] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:34.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:74:0) after 1m0s
[00:48:34.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:74:0)
[00:48:34.867] Timer tick, asking Buildbucket for the build status
[00:48:35.046] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:35.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:75:0) after 1m0s
[00:49:35.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:75:0)
[00:49:35.075] Timer tick, asking Buildbucket for the build status
[00:49:35.300] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:35.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:76:0) after 1m0s
[00:50:35.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:76:0)
[00:50:35.332] Timer tick, asking Buildbucket for the build status
[00:50:35.680] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:35.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:77:0) after 1m0s
[00:51:35.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:77:0)
[00:51:35.705] Timer tick, asking Buildbucket for the build status
[00:51:36.411] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:78:0) after 1m0s
[00:52:36.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:78:0)
[00:52:36.446] Timer tick, asking Buildbucket for the build status
[00:52:37.564] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:37.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:79:0) after 1m0s
[00:53:37.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:79:0)
[00:53:37.595] Timer tick, asking Buildbucket for the build status
[00:53:38.899] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:38.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:80:0) after 1m0s
[00:54:38.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:80:0)
[00:54:38.985] Timer tick, asking Buildbucket for the build status
[00:54:39.591] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:39.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:81:0) after 1m0s
[00:55:39.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:81:0)
[00:55:39.780] Timer tick, asking Buildbucket for the build status
[00:55:40.038] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:82:0) after 1m0s
[00:56:40.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:82:0)
[00:56:40.218] Timer tick, asking Buildbucket for the build status
[00:56:41.296] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:41.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:83:0) after 1m0s
[00:57:41.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:83:0)
[00:57:41.352] Timer tick, asking Buildbucket for the build status
[00:57:41.554] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:41.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:84:0) after 1m0s
[00:58:41.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:84:0)
[00:58:41.648] Timer tick, asking Buildbucket for the build status
[00:58:41.863] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:41.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:85:0) after 1m0s
[00:59:42.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:85:0)
[00:59:42.028] Timer tick, asking Buildbucket for the build status
[00:59:42.198] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:42.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:86:0) after 1m0s
[01:00:42.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:86:0)
[01:00:42.226] Timer tick, asking Buildbucket for the build status
[01:00:42.564] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:42.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:87:0) after 1m0s
[01:01:42.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:87:0)
[01:01:42.621] Timer tick, asking Buildbucket for the build status
[01:01:43.844] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:43.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:88:0) after 1m0s
[01:02:43.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:88:0)
[01:02:43.979] Timer tick, asking Buildbucket for the build status
[01:02:44.185] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:44.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:89:0) after 1m0s
[01:03:44.227] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:89:0)
[01:03:44.227] Timer tick, asking Buildbucket for the build status
[01:03:44.706] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:90:0) after 1m0s
[01:04:44.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:90:0)
[01:04:44.792] Timer tick, asking Buildbucket for the build status
[01:04:45.284] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:45.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:91:0) after 1m0s
[01:05:45.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:91:0)
[01:05:45.540] Timer tick, asking Buildbucket for the build status
[01:05:49.338] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:49.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:92:0) after 1m0s
[01:06:49.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:92:0)
[01:06:49.394] Timer tick, asking Buildbucket for the build status
[01:06:49.642] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:49.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:93:0) after 1m0s
[01:07:49.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:93:0)
[01:07:49.667] Timer tick, asking Buildbucket for the build status
[01:07:49.818] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:49.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:94:0) after 1m0s
[01:08:49.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:94:0)
[01:08:49.940] Timer tick, asking Buildbucket for the build status
[01:08:50.332] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:50.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:95:0) after 1m0s
[01:09:50.474] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:95:0)
[01:09:50.474] Timer tick, asking Buildbucket for the build status
[01:09:50.708] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:50.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:96:0) after 1m0s
[01:10:50.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:96:0)
[01:10:50.827] Timer tick, asking Buildbucket for the build status
[01:10:51.390] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:51.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:97:0) after 1m0s
[01:11:51.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:97:0)
[01:11:51.507] Timer tick, asking Buildbucket for the build status
[01:11:52.683] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:52.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:98:0) after 1m0s
[01:12:52.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:98:0)
[01:12:52.738] Timer tick, asking Buildbucket for the build status
[01:12:53.639] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:53.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:99:0) after 1m0s
[01:13:53.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:99:0)
[01:13:53.728] Timer tick, asking Buildbucket for the build status
[01:13:53.899] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:53.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:100:0) after 1m0s
[01:14:54.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:100:0)
[01:14:54.029] Timer tick, asking Buildbucket for the build status
[01:14:54.366] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:54.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:101:0) after 1m0s
[01:15:54.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:101:0)
[01:15:54.419] Timer tick, asking Buildbucket for the build status
[01:15:54.785] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:54.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:102:0) after 1m0s
[01:16:54.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:102:0)
[01:16:54.909] Timer tick, asking Buildbucket for the build status
[01:16:55.630] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:55.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:103:0) after 1m0s
[01:17:55.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:103:0)
[01:17:55.798] Timer tick, asking Buildbucket for the build status
[01:17:56.415] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:56.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:104:0) after 1m0s
[01:18:56.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:104:0)
[01:18:56.464] Timer tick, asking Buildbucket for the build status
[01:18:57.696] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:57.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:105:0) after 1m0s
[01:19:57.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:105:0)
[01:19:57.674] Timer tick, asking Buildbucket for the build status
[01:19:58.244] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:58.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:106:0) after 1m0s
[01:20:58.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:106:0)
[01:20:58.303] Timer tick, asking Buildbucket for the build status
[01:20:58.699] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:58.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:107:0) after 1m0s
[01:21:58.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:107:0)
[01:21:58.767] Timer tick, asking Buildbucket for the build status
[01:21:59.140] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:59.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:108:0) after 1m0s
[01:22:59.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:108:0)
[01:22:59.233] Timer tick, asking Buildbucket for the build status
[01:22:59.545] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:59.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:109:0) after 1m0s
[01:23:59.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:109:0)
[01:23:59.627] Timer tick, asking Buildbucket for the build status
[01:24:00.212] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:00.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:110:0) after 1m0s
[01:25:00.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:110:0)
[01:25:00.346] Timer tick, asking Buildbucket for the build status
[01:25:00.980] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:00.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:111:0) after 1m0s
[01:26:00.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:111:0)
[01:26:00.999] Timer tick, asking Buildbucket for the build status
[01:26:01.617] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:01.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:112:0) after 1m0s
[01:27:01.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:112:0)
[01:27:01.649] Timer tick, asking Buildbucket for the build status
[01:27:01.838] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:01.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:113:0) after 1m0s
[01:28:01.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:113:0)
[01:28:01.991] Timer tick, asking Buildbucket for the build status
[01:28:02.635] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:02.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:114:0) after 1m0s
[01:29:02.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:114:0)
[01:29:02.673] Timer tick, asking Buildbucket for the build status
[01:29:02.849] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:02.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:115:0) after 1m0s
[01:30:02.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:115:0)
[01:30:02.915] Timer tick, asking Buildbucket for the build status
[01:30:03.093] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:116:0) after 1m0s
[01:31:03.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:116:0)
[01:31:03.179] Timer tick, asking Buildbucket for the build status
[01:31:03.363] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:03.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:117:0) after 1m0s
[01:32:03.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:117:0)
[01:32:03.600] Timer tick, asking Buildbucket for the build status
[01:32:03.786] Build 8891245077848884496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:03.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056675140594235696:118:0) after 1m0s
[01:32:43.448] Received PubSub notification, asking Buildbucket for the build status
[01:32:43.622] Build 8891245077848884496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:32:43.622] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579051962177016",
"created_by": "project:chromium",
"created_ts": "1579044950590818",
"id": "8891245077848884496",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1cf1a551c9899a92cd49754913eda8ea9a3b249b\"}}",
"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-61-95gi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26469, \"got_angle_revision\": \"feb3b6cc6f2b598d001a1166ff03ac64e20de013\", \"got_dawn_revision\": \"cd170a5c7216cfe26572bf380bdfd2e843c1a207\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"1cf1a551c9899a92cd49754913eda8ea9a3b249b\", \"got_revision_cp\": \"refs/heads/master@{#731726}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"146e16f68fdc4678600031ab3256cccf7b32d5e2\", \"got_v8_revision\": \"85f423a4d84295de3950317c7dcc490cd754632d\", \"got_v8_revision_cp\": \"refs/heads/8.1.182@{#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\": \"1cf1a551c9899a92cd49754913eda8ea9a3b249b\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_58f95b007ea60c168bc176676490abae5757dcf141e4048bdc7ee9af9ae02cf5_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-61-95gi\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579045000170720",
"status": "COMPLETED",
"status_changed_ts": "1579051962648045",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26469",
"builder:Deterministic Linux",
"buildset:commit/git/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cf1a551c9899a92cd49754913eda8ea9a3b249b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056675140594235696",
"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/8891245077848884496/+/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:49bf3bd83ed87610",
"user_agent:luci-scheduler"
],
"updated_ts": "1579051962668297",
"url": "https://ci.chromium.org/b/8891245077848884496",
"utcnow_ts": "1579051963613776"
}
}
[01:32:43.622] Invocation finished in 1h56m55.034359558s with status SUCCEEDED