[11:22:46.880] New invocation is queued and will start shortly
[11:22:48.103] Starting the invocation (attempt 1)
[11:22:48.216] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:22:48.216] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:22:48.216] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9038239477628815552",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d4a287a6b9032f2747ee722a0c8a3e5c07872755\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9038239477628815552",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"gitiles_ref:refs/heads/master"
]
}
[11:22:49.243] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1596626568398222",
"id": "8872809415373409888",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4a287a6b9032f2747ee722a0c8a3e5c07872755\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596626568994277",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28716",
"builder:Deterministic Linux",
"buildset:commit/git/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038239477628815552",
"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/8872809415373409888/+/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": "1596626568994392",
"url": "https://ci.chromium.org/b/8872809415373409888",
"utcnow_ts": "1596626569219357"
}
}
[11:22:49.243] Task URL: https://ci.chromium.org/b/8872809415373409888
[11:22:49.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:2:0) after 1m0s
[11:22:53.344] Received PubSub notification, asking Buildbucket for the build status
[11:22:53.584] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:2:0)
[11:23:49.274] Timer tick, asking Buildbucket for the build status
[11:23:49.458] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:4:0) after 1m0s
[11:24:49.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:4:0)
[11:24:49.573] Timer tick, asking Buildbucket for the build status
[11:24:49.639] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:49.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:5:0) after 1m0s
[11:25:49.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:5:0)
[11:25:49.701] Timer tick, asking Buildbucket for the build status
[11:25:49.791] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:49.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:6:0) after 1m0s
[11:26:49.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:6:0)
[11:26:49.853] Timer tick, asking Buildbucket for the build status
[11:26:50.051] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:7:0) after 1m0s
[11:27:50.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:7:0)
[11:27:50.161] Timer tick, asking Buildbucket for the build status
[11:27:50.344] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:8:0) after 1m0s
[11:28:50.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:8:0)
[11:28:50.495] Timer tick, asking Buildbucket for the build status
[11:28:50.892] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:9:0) after 1m0s
[11:29:50.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:9:0)
[11:29:50.960] Timer tick, asking Buildbucket for the build status
[11:29:51.323] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:10:0) after 1m0s
[11:30:51.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:10:0)
[11:30:51.498] Timer tick, asking Buildbucket for the build status
[11:30:51.617] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:11:0) after 1m0s
[11:31:51.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:11:0)
[11:31:51.634] Timer tick, asking Buildbucket for the build status
[11:31:51.704] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:51.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:12:0) after 1m0s
[11:32:51.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:12:0)
[11:32:51.820] Timer tick, asking Buildbucket for the build status
[11:32:52.133] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:52.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:13:0) after 1m0s
[11:33:52.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:13:0)
[11:33:52.208] Timer tick, asking Buildbucket for the build status
[11:33:52.435] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:52.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:14:0) after 1m0s
[11:34:52.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:14:0)
[11:34:52.575] Timer tick, asking Buildbucket for the build status
[11:34:52.731] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:52.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:15:0) after 1m0s
[11:35:52.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:15:0)
[11:35:52.815] Timer tick, asking Buildbucket for the build status
[11:35:52.892] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:16:0) after 1m0s
[11:36:53.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:16:0)
[11:36:53.065] Timer tick, asking Buildbucket for the build status
[11:36:53.797] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:53.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:17:0) after 1m0s
[11:37:53.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:17:0)
[11:37:53.901] Timer tick, asking Buildbucket for the build status
[11:37:54.115] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:18:0) after 1m0s
[11:38:54.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:18:0)
[11:38:54.186] Timer tick, asking Buildbucket for the build status
[11:38:54.361] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:54.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:19:0) after 1m0s
[11:39:54.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:19:0)
[11:39:54.461] Timer tick, asking Buildbucket for the build status
[11:39:54.530] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:54.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:20:0) after 1m0s
[11:40:54.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:20:0)
[11:40:54.697] Timer tick, asking Buildbucket for the build status
[11:40:54.807] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:54.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:21:0) after 1m0s
[11:41:54.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:21:0)
[11:41:54.934] Timer tick, asking Buildbucket for the build status
[11:41:55.164] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:55.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:22:0) after 1m0s
[11:42:55.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:22:0)
[11:42:55.275] Timer tick, asking Buildbucket for the build status
[11:42:55.683] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:55.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:23:0) after 1m0s
[11:43:55.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:23:0)
[11:43:55.745] Timer tick, asking Buildbucket for the build status
[11:43:55.822] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:55.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:24:0) after 1m0s
[11:44:55.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:24:0)
[11:44:55.930] Timer tick, asking Buildbucket for the build status
[11:44:56.246] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:56.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:25:0) after 1m0s
[11:45:56.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:25:0)
[11:45:56.305] Timer tick, asking Buildbucket for the build status
[11:45:56.423] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:56.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:26:0) after 1m0s
[11:46:56.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:26:0)
[11:46:56.471] Timer tick, asking Buildbucket for the build status
[11:46:56.649] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:56.649] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:27:0) after 1m0s
[11:47:56.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:27:0)
[11:47:56.664] Timer tick, asking Buildbucket for the build status
[11:47:56.815] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:56.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:28:0) after 1m0s
[11:48:56.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:28:0)
[11:48:56.950] Timer tick, asking Buildbucket for the build status
[11:48:57.034] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:57.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:29:0) after 1m0s
[11:49:57.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:29:0)
[11:49:57.145] Timer tick, asking Buildbucket for the build status
[11:49:57.243] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:57.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:30:0) after 1m0s
[11:50:57.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:30:0)
[11:50:57.330] Timer tick, asking Buildbucket for the build status
[11:50:57.402] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:57.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:31:0) after 1m0s
[11:51:57.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:31:0)
[11:51:57.503] Timer tick, asking Buildbucket for the build status
[11:51:57.587] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:57.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:32:0) after 1m0s
[11:52:57.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:32:0)
[11:52:57.609] Timer tick, asking Buildbucket for the build status
[11:52:58.031] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:58.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:33:0) after 1m0s
[11:53:58.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:33:0)
[11:53:58.051] Timer tick, asking Buildbucket for the build status
[11:53:58.191] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:58.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:34:0) after 1m0s
[11:54:58.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:34:0)
[11:54:58.321] Timer tick, asking Buildbucket for the build status
[11:54:58.427] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:58.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:35:0) after 1m0s
[11:55:58.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:35:0)
[11:55:58.505] Timer tick, asking Buildbucket for the build status
[11:55:58.602] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:58.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:36:0) after 1m0s
[11:56:58.686] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:36:0)
[11:56:58.686] Timer tick, asking Buildbucket for the build status
[11:56:58.855] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:37:0) after 1m0s
[11:57:58.942] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:37:0)
[11:57:58.942] Timer tick, asking Buildbucket for the build status
[11:57:59.139] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:59.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:38:0) after 1m0s
[11:58:59.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:38:0)
[11:58:59.206] Timer tick, asking Buildbucket for the build status
[11:58:59.326] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:59.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:39:0) after 1m0s
[11:59:59.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:39:0)
[11:59:59.422] Timer tick, asking Buildbucket for the build status
[11:59:59.484] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:59.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:40:0) after 1m0s
[12:00:59.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:40:0)
[12:00:59.658] Timer tick, asking Buildbucket for the build status
[12:00:59.792] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:41:0) after 1m0s
[12:01:59.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:41:0)
[12:01:59.925] Timer tick, asking Buildbucket for the build status
[12:01:59.991] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:42:0) after 1m0s
[12:03:00.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:42:0)
[12:03:00.018] Timer tick, asking Buildbucket for the build status
[12:03:00.277] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:00.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:43:0) after 1m0s
[12:04:00.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:43:0)
[12:04:00.335] Timer tick, asking Buildbucket for the build status
[12:04:00.422] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:00.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:44:0) after 1m0s
[12:05:00.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:44:0)
[12:05:00.501] Timer tick, asking Buildbucket for the build status
[12:05:00.574] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:45:0) after 1m0s
[12:06:00.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:45:0)
[12:06:00.638] Timer tick, asking Buildbucket for the build status
[12:06:00.766] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:00.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:46:0) after 1m0s
[12:07:01.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:46:0)
[12:07:01.168] Timer tick, asking Buildbucket for the build status
[12:07:01.378] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:01.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:47:0) after 1m0s
[12:08:02.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:47:0)
[12:08:02.089] Timer tick, asking Buildbucket for the build status
[12:08:02.564] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:02.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:48:0) after 1m0s
[12:09:02.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:48:0)
[12:09:02.616] Timer tick, asking Buildbucket for the build status
[12:09:02.728] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:02.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:49:0) after 1m0s
[12:10:02.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:49:0)
[12:10:02.763] Timer tick, asking Buildbucket for the build status
[12:10:02.931] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:02.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:50:0) after 1m0s
[12:11:02.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:50:0)
[12:11:02.973] Timer tick, asking Buildbucket for the build status
[12:11:03.410] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:03.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:51:0) after 1m0s
[12:12:03.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:51:0)
[12:12:03.536] Timer tick, asking Buildbucket for the build status
[12:12:03.721] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:03.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:52:0) after 1m0s
[12:13:03.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:52:0)
[12:13:03.771] Timer tick, asking Buildbucket for the build status
[12:13:04.017] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:04.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:53:0) after 1m0s
[12:14:04.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:53:0)
[12:14:04.078] Timer tick, asking Buildbucket for the build status
[12:14:04.150] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:04.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:54:0) after 1m0s
[12:15:04.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:54:0)
[12:15:04.239] Timer tick, asking Buildbucket for the build status
[12:15:04.331] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:04.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:55:0) after 1m0s
[12:16:04.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:55:0)
[12:16:04.432] Timer tick, asking Buildbucket for the build status
[12:16:04.921] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:04.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:56:0) after 1m0s
[12:17:04.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:56:0)
[12:17:04.913] Timer tick, asking Buildbucket for the build status
[12:17:05.221] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:05.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:57:0) after 1m0s
[12:18:05.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:57:0)
[12:18:05.242] Timer tick, asking Buildbucket for the build status
[12:18:05.414] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:05.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:58:0) after 1m0s
[12:19:05.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:58:0)
[12:19:05.578] Timer tick, asking Buildbucket for the build status
[12:19:06.061] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:06.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:59:0) after 1m0s
[12:20:06.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:59:0)
[12:20:06.167] Timer tick, asking Buildbucket for the build status
[12:20:06.318] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:06.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:60:0) after 1m0s
[12:21:06.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:60:0)
[12:21:06.364] Timer tick, asking Buildbucket for the build status
[12:21:06.452] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:06.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:61:0) after 1m0s
[12:22:06.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:61:0)
[12:22:06.476] Timer tick, asking Buildbucket for the build status
[12:22:06.574] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:06.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:62:0) after 1m0s
[12:23:06.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:62:0)
[12:23:06.644] Timer tick, asking Buildbucket for the build status
[12:23:06.826] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:63:0) after 1m0s
[12:24:06.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:63:0)
[12:24:06.862] Timer tick, asking Buildbucket for the build status
[12:24:06.962] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:06.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:64:0) after 1m0s
[12:25:06.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:64:0)
[12:25:06.995] Timer tick, asking Buildbucket for the build status
[12:25:07.334] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:07.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:65:0) after 1m0s
[12:26:07.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:65:0)
[12:26:07.361] Timer tick, asking Buildbucket for the build status
[12:26:07.546] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:66:0) after 1m0s
[12:27:07.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:66:0)
[12:27:07.579] Timer tick, asking Buildbucket for the build status
[12:27:07.943] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:07.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:67:0) after 1m0s
[12:28:08.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:67:0)
[12:28:08.018] Timer tick, asking Buildbucket for the build status
[12:28:09.075] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:09.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:68:0) after 1m0s
[12:29:09.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:68:0)
[12:29:09.207] Timer tick, asking Buildbucket for the build status
[12:29:09.405] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:09.405] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:69:0) after 1m0s
[12:30:09.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:69:0)
[12:30:09.537] Timer tick, asking Buildbucket for the build status
[12:30:09.663] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:09.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:70:0) after 1m0s
[12:31:09.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:70:0)
[12:31:09.846] Timer tick, asking Buildbucket for the build status
[12:31:09.929] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:09.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:71:0) after 1m0s
[12:32:10.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:71:0)
[12:32:10.194] Timer tick, asking Buildbucket for the build status
[12:32:10.267] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:10.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:72:0) after 1m0s
[12:33:10.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:72:0)
[12:33:10.379] Timer tick, asking Buildbucket for the build status
[12:33:10.488] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:10.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:73:0) after 1m0s
[12:34:10.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:73:0)
[12:34:10.576] Timer tick, asking Buildbucket for the build status
[12:34:10.668] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:10.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:74:0) after 1m0s
[12:35:10.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:74:0)
[12:35:10.791] Timer tick, asking Buildbucket for the build status
[12:35:10.881] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:10.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:75:0) after 1m0s
[12:36:11.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:75:0)
[12:36:11.005] Timer tick, asking Buildbucket for the build status
[12:36:11.066] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:11.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:76:0) after 1m0s
[12:37:11.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:76:0)
[12:37:11.134] Timer tick, asking Buildbucket for the build status
[12:37:11.501] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:11.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:77:0) after 1m0s
[12:38:11.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:77:0)
[12:38:11.680] Timer tick, asking Buildbucket for the build status
[12:38:11.810] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:11.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:78:0) after 1m0s
[12:39:11.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:78:0)
[12:39:11.952] Timer tick, asking Buildbucket for the build status
[12:39:12.019] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:12.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:79:0) after 1m0s
[12:40:12.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:79:0)
[12:40:12.007] Timer tick, asking Buildbucket for the build status
[12:40:12.304] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:12.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:80:0) after 1m0s
[12:41:12.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:80:0)
[12:41:12.348] Timer tick, asking Buildbucket for the build status
[12:41:12.428] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:12.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:81:0) after 1m0s
[12:42:12.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:81:0)
[12:42:12.482] Timer tick, asking Buildbucket for the build status
[12:42:12.693] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:12.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:82:0) after 1m0s
[12:43:12.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:82:0)
[12:43:12.673] Timer tick, asking Buildbucket for the build status
[12:43:12.791] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:12.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:83:0) after 1m0s
[12:44:12.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:83:0)
[12:44:12.816] Timer tick, asking Buildbucket for the build status
[12:44:12.890] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:12.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:84:0) after 1m0s
[12:45:12.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:84:0)
[12:45:12.951] Timer tick, asking Buildbucket for the build status
[12:45:13.101] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:13.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:85:0) after 1m0s
[12:46:13.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:85:0)
[12:46:13.142] Timer tick, asking Buildbucket for the build status
[12:46:13.291] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:86:0) after 1m0s
[12:47:13.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:86:0)
[12:47:13.383] Timer tick, asking Buildbucket for the build status
[12:47:13.454] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:13.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:87:0) after 1m0s
[12:48:13.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:87:0)
[12:48:13.483] Timer tick, asking Buildbucket for the build status
[12:48:13.918] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:13.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:88:0) after 1m0s
[12:49:14.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:88:0)
[12:49:14.051] Timer tick, asking Buildbucket for the build status
[12:49:14.575] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:14.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:89:0) after 1m0s
[12:50:14.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:89:0)
[12:50:14.639] Timer tick, asking Buildbucket for the build status
[12:50:14.753] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:14.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:90:0) after 1m0s
[12:51:14.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:90:0)
[12:51:14.768] Timer tick, asking Buildbucket for the build status
[12:51:14.925] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:14.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:91:0) after 1m0s
[12:52:14.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:91:0)
[12:52:14.990] Timer tick, asking Buildbucket for the build status
[12:52:15.127] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:15.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:92:0) after 1m0s
[12:53:15.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:92:0)
[12:53:15.181] Timer tick, asking Buildbucket for the build status
[12:53:15.312] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:15.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:93:0) after 1m0s
[12:54:15.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:93:0)
[12:54:15.379] Timer tick, asking Buildbucket for the build status
[12:54:15.448] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:15.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:94:0) after 1m0s
[12:55:16.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:94:0)
[12:55:16.762] Timer tick, asking Buildbucket for the build status
[12:55:17.632] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:17.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:95:0) after 1m0s
[12:56:17.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:95:0)
[12:56:17.856] Timer tick, asking Buildbucket for the build status
[12:56:18.016] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:18.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:96:0) after 1m0s
[12:57:18.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:96:0)
[12:57:18.137] Timer tick, asking Buildbucket for the build status
[12:57:18.309] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:18.309] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:97:0) after 1m0s
[12:58:18.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:97:0)
[12:58:18.429] Timer tick, asking Buildbucket for the build status
[12:58:18.812] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:18.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:98:0) after 1m0s
[12:59:18.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:98:0)
[12:59:18.855] Timer tick, asking Buildbucket for the build status
[12:59:18.935] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:99:0) after 1m0s
[13:00:18.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:99:0)
[13:00:18.968] Timer tick, asking Buildbucket for the build status
[13:00:19.543] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:19.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:100:0) after 1m0s
[13:01:19.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:100:0)
[13:01:19.648] Timer tick, asking Buildbucket for the build status
[13:01:19.814] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:19.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:101:0) after 1m0s
[13:02:19.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:101:0)
[13:02:19.941] Timer tick, asking Buildbucket for the build status
[13:02:20.042] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:20.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:102:0) after 1m0s
[13:03:20.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:102:0)
[13:03:20.123] Timer tick, asking Buildbucket for the build status
[13:03:20.384] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:20.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:103:0) after 1m0s
[13:04:20.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:103:0)
[13:04:20.537] Timer tick, asking Buildbucket for the build status
[13:04:20.617] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:20.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:104:0) after 1m0s
[13:05:20.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:104:0)
[13:05:20.621] Timer tick, asking Buildbucket for the build status
[13:05:20.719] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:20.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:105:0) after 1m0s
[13:06:20.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:105:0)
[13:06:20.798] Timer tick, asking Buildbucket for the build status
[13:06:20.920] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:20.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:106:0) after 1m0s
[13:07:21.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:106:0)
[13:07:21.080] Timer tick, asking Buildbucket for the build status
[13:07:21.185] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:21.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:107:0) after 1m0s
[13:08:21.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:107:0)
[13:08:21.267] Timer tick, asking Buildbucket for the build status
[13:08:21.478] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:21.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:108:0) after 1m0s
[13:09:21.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:108:0)
[13:09:21.692] Timer tick, asking Buildbucket for the build status
[13:09:21.770] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:21.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:109:0) after 1m0s
[13:10:21.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:109:0)
[13:10:21.809] Timer tick, asking Buildbucket for the build status
[13:10:22.096] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:22.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:110:0) after 1m0s
[13:11:22.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:110:0)
[13:11:22.197] Timer tick, asking Buildbucket for the build status
[13:11:22.276] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:22.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:111:0) after 1m0s
[13:12:22.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:111:0)
[13:12:22.407] Timer tick, asking Buildbucket for the build status
[13:12:22.489] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:22.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:112:0) after 1m0s
[13:13:22.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:112:0)
[13:13:22.561] Timer tick, asking Buildbucket for the build status
[13:13:22.675] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:113:0) after 1m0s
[13:14:22.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:113:0)
[13:14:22.747] Timer tick, asking Buildbucket for the build status
[13:14:23.104] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:23.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:114:0) after 1m0s
[13:15:23.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:114:0)
[13:15:23.155] Timer tick, asking Buildbucket for the build status
[13:15:23.224] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:23.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:115:0) after 1m0s
[13:16:23.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:115:0)
[13:16:23.226] Timer tick, asking Buildbucket for the build status
[13:16:23.304] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:23.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:116:0) after 1m0s
[13:17:23.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:116:0)
[13:17:23.328] Timer tick, asking Buildbucket for the build status
[13:17:23.408] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:23.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:117:0) after 1m0s
[13:18:23.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:117:0)
[13:18:23.532] Timer tick, asking Buildbucket for the build status
[13:18:23.928] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:23.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:118:0) after 1m0s
[13:19:24.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:118:0)
[13:19:24.002] Timer tick, asking Buildbucket for the build status
[13:19:24.157] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:24.157] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:119:0) after 1m0s
[13:20:24.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:119:0)
[13:20:24.265] Timer tick, asking Buildbucket for the build status
[13:20:24.357] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:24.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:120:0) after 1m0s
[13:21:24.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:120:0)
[13:21:24.504] Timer tick, asking Buildbucket for the build status
[13:21:24.625] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:24.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:121:0) after 1m0s
[13:22:24.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:121:0)
[13:22:24.606] Timer tick, asking Buildbucket for the build status
[13:22:24.701] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:24.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:122:0) after 1m0s
[13:23:24.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:122:0)
[13:23:24.841] Timer tick, asking Buildbucket for the build status
[13:23:25.216] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:25.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:123:0) after 1m0s
[13:24:25.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:123:0)
[13:24:25.314] Timer tick, asking Buildbucket for the build status
[13:24:25.582] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:25.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:124:0) after 1m0s
[13:25:25.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:124:0)
[13:25:25.767] Timer tick, asking Buildbucket for the build status
[13:25:25.992] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:125:0) after 1m0s
[13:26:26.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:125:0)
[13:26:26.485] Timer tick, asking Buildbucket for the build status
[13:26:27.939] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:27.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:126:0) after 1m0s
[13:27:27.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:126:0)
[13:27:27.936] Timer tick, asking Buildbucket for the build status
[13:27:29.978] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:29.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:127:0) after 1m0s
[13:28:30.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:127:0)
[13:28:30.039] Timer tick, asking Buildbucket for the build status
[13:28:30.342] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:30.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:128:0) after 1m0s
[13:29:30.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:128:0)
[13:29:30.373] Timer tick, asking Buildbucket for the build status
[13:29:30.470] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:30.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:129:0) after 1m0s
[13:30:30.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:129:0)
[13:30:30.559] Timer tick, asking Buildbucket for the build status
[13:30:30.769] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:30.769] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:130:0) after 1m0s
[13:31:30.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:130:0)
[13:31:30.815] Timer tick, asking Buildbucket for the build status
[13:31:31.001] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:131:0) after 1m0s
[13:32:31.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:131:0)
[13:32:31.049] Timer tick, asking Buildbucket for the build status
[13:32:31.477] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:31.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:132:0) after 1m0s
[13:33:31.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:132:0)
[13:33:31.542] Timer tick, asking Buildbucket for the build status
[13:33:33.102] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:33.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:133:0) after 1m0s
[13:34:33.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:133:0)
[13:34:33.196] Timer tick, asking Buildbucket for the build status
[13:34:33.298] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:33.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:134:0) after 1m0s
[13:35:33.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:134:0)
[13:35:33.398] Timer tick, asking Buildbucket for the build status
[13:35:33.658] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:33.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:135:0) after 1m0s
[13:36:33.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:135:0)
[13:36:33.687] Timer tick, asking Buildbucket for the build status
[13:36:33.861] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:136:0) after 1m0s
[13:37:33.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:136:0)
[13:37:33.890] Timer tick, asking Buildbucket for the build status
[13:37:34.032] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:34.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:137:0) after 1m0s
[13:38:34.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:137:0)
[13:38:34.074] Timer tick, asking Buildbucket for the build status
[13:38:34.246] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:34.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:138:0) after 1m0s
[13:39:34.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:138:0)
[13:39:34.348] Timer tick, asking Buildbucket for the build status
[13:39:34.467] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:34.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:139:0) after 1m0s
[13:40:34.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:139:0)
[13:40:34.521] Timer tick, asking Buildbucket for the build status
[13:40:34.623] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:140:0) after 1m0s
[13:41:34.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:140:0)
[13:41:34.658] Timer tick, asking Buildbucket for the build status
[13:41:34.797] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:34.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:141:0) after 1m0s
[13:42:34.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:141:0)
[13:42:34.854] Timer tick, asking Buildbucket for the build status
[13:42:35.527] Build 8872809415373409888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:35.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9038239477628815552:142:0) after 1m0s
[13:43:34.158] Received PubSub notification, asking Buildbucket for the build status
[13:43:34.293] Build 8872809415373409888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:43:34.293] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1596635013258901",
"created_by": "project:chromium",
"created_ts": "1596626568398222",
"id": "8872809415373409888",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4a287a6b9032f2747ee722a0c8a3e5c07872755\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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-47-mdpi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28716, \"got_angle_revision\": \"25b0de6bd00fc23973b6b23bab61c83c589f2b06\", \"got_dawn_revision\": \"076a4e58205dfa2bcf5e33cc8718aa4799d46735\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"d4a287a6b9032f2747ee722a0c8a3e5c07872755\", \"got_revision_cp\": \"refs/heads/master@{#794968}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"be7c55a2a8cebd46ba6912e6b7d4dae8353d154c\", \"got_v8_revision\": \"ce4c3060f6fbfd5ed410de314f7e83a66fd792d9\", \"got_v8_revision_cp\": \"refs/heads/8.6.334@{#1}\", \"got_webrtc_revision\": \"7e30909bf44a224f7dbb49fc6bac6f2fdd4fd822\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31842}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4a287a6b9032f2747ee722a0c8a3e5c07872755\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6337027b9f5c92bb839aef39a1f908f5aaa6ec745f5c7fe76eeae24bfbb4f02b_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-47-mdpi\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1596626572603805",
"status": "COMPLETED",
"status_changed_ts": "1596635013834835",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28716",
"builder:Deterministic Linux",
"buildset:commit/git/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4a287a6b9032f2747ee722a0c8a3e5c07872755",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038239477628815552",
"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/8872809415373409888/+/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:4dd72d905914c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1596635013841088",
"url": "https://ci.chromium.org/b/8872809415373409888",
"utcnow_ts": "1596635014274511"
}
}
[13:43:34.293] Invocation finished in 2h20m47.429933359s with status SUCCEEDED