[00:32:58.335] New invocation is queued and will start shortly
[00:32:59.420] Starting the invocation (attempt 1)
[00:32:59.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:32:59.467] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:32:59.467] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026774545350996240",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ead2ff26c3b0c78755bb198e532691d6a1ee2f38\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9026774545350996240",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"gitiles_ref:refs/heads/master"
]
}
[00:33:00.202] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607560379555597",
"id": "8861344483406093536",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ead2ff26c3b0c78755bb198e532691d6a1ee2f38\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607560380000237",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/19942",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026774545350996240",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861344483406093536/+/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": "1607560380000593",
"url": "https://ci.chromium.org/b/8861344483406093536",
"utcnow_ts": "1607560380115914"
}
}
[00:33:00.202] Task URL: https://ci.chromium.org/b/8861344483406093536
[00:33:00.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:2:0) after 1m0s
[00:33:13.218] Received PubSub notification, asking Buildbucket for the build status
[00:33:13.281] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:00.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:2:0)
[00:34:00.218] Timer tick, asking Buildbucket for the build status
[00:34:00.319] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:00.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:4:0) after 1m0s
[00:35:00.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:4:0)
[00:35:00.340] Timer tick, asking Buildbucket for the build status
[00:35:00.467] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:00.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:5:0) after 1m0s
[00:36:00.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:5:0)
[00:36:00.509] Timer tick, asking Buildbucket for the build status
[00:36:00.607] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:00.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:6:0) after 1m0s
[00:37:00.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:6:0)
[00:37:00.631] Timer tick, asking Buildbucket for the build status
[00:37:00.708] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:00.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:7:0) after 1m0s
[00:38:01.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:7:0)
[00:38:01.308] Timer tick, asking Buildbucket for the build status
[00:38:01.464] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:01.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:8:0) after 1m0s
[00:39:02.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:8:0)
[00:39:02.418] Timer tick, asking Buildbucket for the build status
[00:39:02.564] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:02.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:9:0) after 1m0s
[00:40:02.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:9:0)
[00:40:02.567] Timer tick, asking Buildbucket for the build status
[00:40:02.629] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:10:0) after 1m0s
[00:41:02.681] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:10:0)
[00:41:02.681] Timer tick, asking Buildbucket for the build status
[00:41:02.806] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:02.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:11:0) after 1m0s
[00:42:02.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:11:0)
[00:42:02.882] Timer tick, asking Buildbucket for the build status
[00:42:03.359] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:03.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:12:0) after 1m0s
[00:43:03.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:12:0)
[00:43:03.423] Timer tick, asking Buildbucket for the build status
[00:43:03.485] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:03.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:13:0) after 1m0s
[00:44:03.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:13:0)
[00:44:03.493] Timer tick, asking Buildbucket for the build status
[00:44:03.817] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:03.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:14:0) after 1m0s
[00:45:03.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:14:0)
[00:45:03.882] Timer tick, asking Buildbucket for the build status
[00:45:04.250] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:04.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:15:0) after 1m0s
[00:46:04.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:15:0)
[00:46:04.229] Timer tick, asking Buildbucket for the build status
[00:46:04.343] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:04.343] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:16:0) after 1m0s
[00:47:04.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:16:0)
[00:47:04.374] Timer tick, asking Buildbucket for the build status
[00:47:04.440] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:04.440] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:17:0) after 1m0s
[00:48:04.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:17:0)
[00:48:04.522] Timer tick, asking Buildbucket for the build status
[00:48:04.980] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:04.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:18:0) after 1m0s
[00:49:05.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:18:0)
[00:49:05.039] Timer tick, asking Buildbucket for the build status
[00:49:05.119] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:05.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:19:0) after 1m0s
[00:50:05.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:19:0)
[00:50:05.193] Timer tick, asking Buildbucket for the build status
[00:50:05.310] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:05.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:20:0) after 1m0s
[00:51:05.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:20:0)
[00:51:05.506] Timer tick, asking Buildbucket for the build status
[00:51:05.675] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:05.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:21:0) after 1m0s
[00:52:05.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:21:0)
[00:52:05.738] Timer tick, asking Buildbucket for the build status
[00:52:05.940] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:05.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:22:0) after 1m0s
[00:53:06.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:22:0)
[00:53:06.010] Timer tick, asking Buildbucket for the build status
[00:53:06.115] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:23:0) after 1m0s
[00:54:06.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:23:0)
[00:54:06.582] Timer tick, asking Buildbucket for the build status
[00:54:06.752] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:06.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:24:0) after 1m0s
[00:55:06.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:24:0)
[00:55:06.820] Timer tick, asking Buildbucket for the build status
[00:55:06.928] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:06.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:25:0) after 1m0s
[00:56:07.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:25:0)
[00:56:07.044] Timer tick, asking Buildbucket for the build status
[00:56:07.151] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:07.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:26:0) after 1m0s
[00:57:07.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:26:0)
[00:57:07.358] Timer tick, asking Buildbucket for the build status
[00:57:07.447] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:07.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:27:0) after 1m0s
[00:58:07.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:27:0)
[00:58:07.509] Timer tick, asking Buildbucket for the build status
[00:58:07.840] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:07.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:28:0) after 1m0s
[00:59:08.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:28:0)
[00:59:08.040] Timer tick, asking Buildbucket for the build status
[00:59:08.107] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:29:0) after 1m0s
[01:00:08.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:29:0)
[01:00:08.224] Timer tick, asking Buildbucket for the build status
[01:00:08.388] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:08.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:30:0) after 1m0s
[01:01:08.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:30:0)
[01:01:08.514] Timer tick, asking Buildbucket for the build status
[01:01:08.631] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:08.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:31:0) after 1m0s
[01:02:08.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:31:0)
[01:02:08.714] Timer tick, asking Buildbucket for the build status
[01:02:08.831] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:08.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:32:0) after 1m0s
[01:03:09.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:32:0)
[01:03:09.018] Timer tick, asking Buildbucket for the build status
[01:03:09.302] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:09.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:33:0) after 1m0s
[01:04:09.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:33:0)
[01:04:09.466] Timer tick, asking Buildbucket for the build status
[01:04:09.792] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:09.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:34:0) after 1m0s
[01:05:09.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:34:0)
[01:05:09.827] Timer tick, asking Buildbucket for the build status
[01:05:09.894] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:09.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:35:0) after 1m0s
[01:06:09.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:35:0)
[01:06:09.975] Timer tick, asking Buildbucket for the build status
[01:06:10.392] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:10.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:36:0) after 1m0s
[01:07:10.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:36:0)
[01:07:10.520] Timer tick, asking Buildbucket for the build status
[01:07:10.846] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:10.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:37:0) after 1m0s
[01:08:10.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:37:0)
[01:08:10.864] Timer tick, asking Buildbucket for the build status
[01:08:10.959] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:10.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:38:0) after 1m0s
[01:09:10.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:38:0)
[01:09:10.987] Timer tick, asking Buildbucket for the build status
[01:09:11.086] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:11.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:39:0) after 1m0s
[01:10:11.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:39:0)
[01:10:11.139] Timer tick, asking Buildbucket for the build status
[01:10:11.215] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:40:0) after 1m0s
[01:11:11.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:40:0)
[01:11:11.317] Timer tick, asking Buildbucket for the build status
[01:11:11.467] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:11.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:41:0) after 1m0s
[01:12:11.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:41:0)
[01:12:11.505] Timer tick, asking Buildbucket for the build status
[01:12:11.564] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:11.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:42:0) after 1m0s
[01:13:11.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:42:0)
[01:13:11.597] Timer tick, asking Buildbucket for the build status
[01:13:11.684] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:11.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:43:0) after 1m0s
[01:14:11.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:43:0)
[01:14:11.735] Timer tick, asking Buildbucket for the build status
[01:14:11.802] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:11.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:44:0) after 1m0s
[01:15:12.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:44:0)
[01:15:12.003] Timer tick, asking Buildbucket for the build status
[01:15:12.335] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:12.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:45:0) after 1m0s
[01:16:12.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:45:0)
[01:16:12.467] Timer tick, asking Buildbucket for the build status
[01:16:12.559] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:12.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:46:0) after 1m0s
[01:17:12.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:46:0)
[01:17:12.626] Timer tick, asking Buildbucket for the build status
[01:17:12.732] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:12.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:47:0) after 1m0s
[01:18:12.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:47:0)
[01:18:12.846] Timer tick, asking Buildbucket for the build status
[01:18:12.996] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:12.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:48:0) after 1m0s
[01:19:13.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:48:0)
[01:19:13.096] Timer tick, asking Buildbucket for the build status
[01:19:13.244] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:13.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:49:0) after 1m0s
[01:20:13.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:49:0)
[01:20:13.271] Timer tick, asking Buildbucket for the build status
[01:20:13.345] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:13.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:50:0) after 1m0s
[01:21:13.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:50:0)
[01:21:13.354] Timer tick, asking Buildbucket for the build status
[01:21:13.524] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:13.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:51:0) after 1m0s
[01:22:13.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:51:0)
[01:22:13.599] Timer tick, asking Buildbucket for the build status
[01:22:13.733] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:52:0) after 1m0s
[01:23:13.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:52:0)
[01:23:13.772] Timer tick, asking Buildbucket for the build status
[01:23:14.476] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:53:0) after 1m0s
[01:24:14.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:53:0)
[01:24:14.567] Timer tick, asking Buildbucket for the build status
[01:24:14.900] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:14.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:54:0) after 1m0s
[01:25:14.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:54:0)
[01:25:14.923] Timer tick, asking Buildbucket for the build status
[01:25:15.204] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:15.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:55:0) after 1m0s
[01:26:15.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:55:0)
[01:26:15.231] Timer tick, asking Buildbucket for the build status
[01:26:15.379] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:15.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:56:0) after 1m0s
[01:27:15.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:56:0)
[01:27:15.410] Timer tick, asking Buildbucket for the build status
[01:27:15.891] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:15.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:57:0) after 1m0s
[01:28:15.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:57:0)
[01:28:15.923] Timer tick, asking Buildbucket for the build status
[01:28:16.022] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:58:0) after 1m0s
[01:29:16.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:58:0)
[01:29:16.127] Timer tick, asking Buildbucket for the build status
[01:29:16.199] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:16.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:59:0) after 1m0s
[01:30:16.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:59:0)
[01:30:16.269] Timer tick, asking Buildbucket for the build status
[01:30:16.358] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:16.358] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:60:0) after 1m0s
[01:31:16.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:60:0)
[01:31:16.388] Timer tick, asking Buildbucket for the build status
[01:31:16.530] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:61:0) after 1m0s
[01:32:16.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:61:0)
[01:32:16.583] Timer tick, asking Buildbucket for the build status
[01:32:16.736] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:16.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:62:0) after 1m0s
[01:33:17.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:62:0)
[01:33:17.014] Timer tick, asking Buildbucket for the build status
[01:33:17.982] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:17.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:63:0) after 1m0s
[01:34:17.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:63:0)
[01:34:17.975] Timer tick, asking Buildbucket for the build status
[01:34:18.051] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:18.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:64:0) after 1m0s
[01:35:18.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:64:0)
[01:35:18.077] Timer tick, asking Buildbucket for the build status
[01:35:18.136] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:65:0) after 1m0s
[01:36:18.211] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:65:0)
[01:36:18.211] Timer tick, asking Buildbucket for the build status
[01:36:18.441] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:18.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:66:0) after 1m0s
[01:37:18.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:66:0)
[01:37:18.495] Timer tick, asking Buildbucket for the build status
[01:37:18.575] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:18.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:67:0) after 1m0s
[01:38:18.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:67:0)
[01:38:18.709] Timer tick, asking Buildbucket for the build status
[01:38:19.107] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:19.107] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:68:0) after 1m0s
[01:39:19.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:68:0)
[01:39:19.186] Timer tick, asking Buildbucket for the build status
[01:39:19.311] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:19.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:69:0) after 1m0s
[01:40:19.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:69:0)
[01:40:19.379] Timer tick, asking Buildbucket for the build status
[01:40:19.452] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:19.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:70:0) after 1m0s
[01:41:19.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:70:0)
[01:41:19.515] Timer tick, asking Buildbucket for the build status
[01:41:19.577] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:19.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:71:0) after 1m0s
[01:42:19.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:71:0)
[01:42:19.604] Timer tick, asking Buildbucket for the build status
[01:42:19.677] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:19.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:72:0) after 1m0s
[01:43:19.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:72:0)
[01:43:19.692] Timer tick, asking Buildbucket for the build status
[01:43:19.904] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:19.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:73:0) after 1m0s
[01:44:19.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:73:0)
[01:44:19.905] Timer tick, asking Buildbucket for the build status
[01:44:19.962] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:19.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:74:0) after 1m0s
[01:45:19.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:74:0)
[01:45:19.993] Timer tick, asking Buildbucket for the build status
[01:45:20.057] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:20.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:75:0) after 1m0s
[01:46:20.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:75:0)
[01:46:20.221] Timer tick, asking Buildbucket for the build status
[01:46:20.297] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:20.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:76:0) after 1m0s
[01:47:20.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:76:0)
[01:47:20.507] Timer tick, asking Buildbucket for the build status
[01:47:20.584] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:20.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:77:0) after 1m0s
[01:48:20.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:77:0)
[01:48:20.854] Timer tick, asking Buildbucket for the build status
[01:48:20.958] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:20.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:78:0) after 1m0s
[01:49:21.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:78:0)
[01:49:21.036] Timer tick, asking Buildbucket for the build status
[01:49:21.111] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:21.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:79:0) after 1m0s
[01:50:21.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:79:0)
[01:50:21.277] Timer tick, asking Buildbucket for the build status
[01:50:21.348] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:21.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:80:0) after 1m0s
[01:51:21.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:80:0)
[01:51:21.590] Timer tick, asking Buildbucket for the build status
[01:51:21.652] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:21.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:81:0) after 1m0s
[01:52:21.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:81:0)
[01:52:21.824] Timer tick, asking Buildbucket for the build status
[01:52:21.882] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:21.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:82:0) after 1m0s
[01:53:22.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:82:0)
[01:53:22.076] Timer tick, asking Buildbucket for the build status
[01:53:22.179] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:22.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:83:0) after 1m0s
[01:54:22.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:83:0)
[01:54:22.273] Timer tick, asking Buildbucket for the build status
[01:54:22.338] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:22.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:84:0) after 1m0s
[01:55:22.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:84:0)
[01:55:22.486] Timer tick, asking Buildbucket for the build status
[01:55:22.612] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:22.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:85:0) after 1m0s
[01:56:22.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:85:0)
[01:56:22.688] Timer tick, asking Buildbucket for the build status
[01:56:22.789] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:22.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:86:0) after 1m0s
[01:57:23.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:86:0)
[01:57:23.042] Timer tick, asking Buildbucket for the build status
[01:57:23.152] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:23.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:87:0) after 1m0s
[01:58:23.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:87:0)
[01:58:23.294] Timer tick, asking Buildbucket for the build status
[01:58:23.384] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:23.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:88:0) after 1m0s
[01:59:23.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:88:0)
[01:59:23.458] Timer tick, asking Buildbucket for the build status
[01:59:23.569] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:23.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:89:0) after 1m0s
[02:00:23.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:89:0)
[02:00:23.654] Timer tick, asking Buildbucket for the build status
[02:00:23.856] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:23.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:90:0) after 1m0s
[02:01:23.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:90:0)
[02:01:23.888] Timer tick, asking Buildbucket for the build status
[02:01:24.129] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:24.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:91:0) after 1m0s
[02:02:24.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:91:0)
[02:02:24.162] Timer tick, asking Buildbucket for the build status
[02:02:24.539] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:24.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:92:0) after 1m0s
[02:03:24.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:92:0)
[02:03:24.587] Timer tick, asking Buildbucket for the build status
[02:03:24.730] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:24.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:93:0) after 1m0s
[02:04:24.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:93:0)
[02:04:24.832] Timer tick, asking Buildbucket for the build status
[02:04:24.922] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:24.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:94:0) after 1m0s
[02:05:24.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:94:0)
[02:05:24.940] Timer tick, asking Buildbucket for the build status
[02:05:25.149] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:25.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:95:0) after 1m0s
[02:06:25.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:95:0)
[02:06:25.182] Timer tick, asking Buildbucket for the build status
[02:06:25.285] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:25.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:96:0) after 1m0s
[02:07:25.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:96:0)
[02:07:25.375] Timer tick, asking Buildbucket for the build status
[02:07:25.460] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:97:0) after 1m0s
[02:08:25.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:97:0)
[02:08:25.487] Timer tick, asking Buildbucket for the build status
[02:08:25.636] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:25.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:98:0) after 1m0s
[02:09:25.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:98:0)
[02:09:25.719] Timer tick, asking Buildbucket for the build status
[02:09:25.794] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:25.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:99:0) after 1m0s
[02:10:25.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:99:0)
[02:10:25.804] Timer tick, asking Buildbucket for the build status
[02:10:25.868] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:25.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:100:0) after 1m0s
[02:11:25.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:100:0)
[02:11:25.880] Timer tick, asking Buildbucket for the build status
[02:11:25.951] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:25.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:101:0) after 1m0s
[02:12:25.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:101:0)
[02:12:25.985] Timer tick, asking Buildbucket for the build status
[02:12:26.146] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:26.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:102:0) after 1m0s
[02:13:26.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:102:0)
[02:13:26.172] Timer tick, asking Buildbucket for the build status
[02:13:26.315] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:103:0) after 1m0s
[02:14:26.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:103:0)
[02:14:26.367] Timer tick, asking Buildbucket for the build status
[02:14:26.419] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:26.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:104:0) after 1m0s
[02:15:26.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:104:0)
[02:15:26.491] Timer tick, asking Buildbucket for the build status
[02:15:26.561] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:26.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:105:0) after 1m0s
[02:16:26.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:105:0)
[02:16:26.608] Timer tick, asking Buildbucket for the build status
[02:16:26.906] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:26.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:106:0) after 1m0s
[02:17:26.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:106:0)
[02:17:26.969] Timer tick, asking Buildbucket for the build status
[02:17:27.064] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:27.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:107:0) after 1m0s
[02:18:27.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:107:0)
[02:18:27.197] Timer tick, asking Buildbucket for the build status
[02:18:27.326] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:27.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:108:0) after 1m0s
[02:19:27.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:108:0)
[02:19:27.469] Timer tick, asking Buildbucket for the build status
[02:19:27.805] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:109:0) after 1m0s
[02:20:27.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:109:0)
[02:20:27.881] Timer tick, asking Buildbucket for the build status
[02:20:27.938] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:27.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:110:0) after 1m0s
[02:21:28.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:110:0)
[02:21:28.063] Timer tick, asking Buildbucket for the build status
[02:21:28.128] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:28.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:111:0) after 1m0s
[02:22:28.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:111:0)
[02:22:28.222] Timer tick, asking Buildbucket for the build status
[02:22:28.497] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:28.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:112:0) after 1m0s
[02:23:28.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:112:0)
[02:23:28.536] Timer tick, asking Buildbucket for the build status
[02:23:28.706] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:28.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:113:0) after 1m0s
[02:24:28.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:113:0)
[02:24:28.783] Timer tick, asking Buildbucket for the build status
[02:24:28.887] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:28.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:114:0) after 1m0s
[02:25:28.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:114:0)
[02:25:28.919] Timer tick, asking Buildbucket for the build status
[02:25:28.984] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:28.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:115:0) after 1m0s
[02:26:29.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:115:0)
[02:26:29.073] Timer tick, asking Buildbucket for the build status
[02:26:29.143] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:29.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:116:0) after 1m0s
[02:27:29.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:116:0)
[02:27:29.148] Timer tick, asking Buildbucket for the build status
[02:27:29.209] Build 8861344483406093536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9026774545350996240:117:0) after 1m0s
[02:27:51.452] Received PubSub notification, asking Buildbucket for the build status
[02:27:51.526] Build 8861344483406093536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:27:51.526] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607567270467426",
"created_by": "project:chromium",
"created_ts": "1607560379555597",
"id": "8861344483406093536",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ead2ff26c3b0c78755bb198e532691d6a1ee2f38\"}}",
"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\", \"use_luci_auth\": true}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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-32-14-x5zh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 19942, \"got_angle_revision\": \"378653f844d404993507bbc81245ff674c0dc8c6\", \"got_dawn_revision\": \"29fd62989338a0d5812bc654a3afee6dc684bfc4\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"ead2ff26c3b0c78755bb198e532691d6a1ee2f38\", \"got_revision_cp\": \"refs/heads/master@{#835459}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"f4c21136e60a69bed428916f427115a250d0739c\", \"got_v8_revision\": \"7e546be6b2f61eb429d51abb78e973f7f623f62f\", \"got_v8_revision_cp\": \"refs/heads/8.9.126@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ead2ff26c3b0c78755bb198e532691d6a1ee2f38\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-14-x5zh\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607560387359200",
"status": "COMPLETED",
"status_changed_ts": "1607567270831251",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/19942",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ead2ff26c3b0c78755bb198e532691d6a1ee2f38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026774545350996240",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861344483406093536/+/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:5062e2530d1de410",
"user_agent:luci-scheduler"
],
"updated_ts": "1607567270838507",
"url": "https://ci.chromium.org/b/8861344483406093536",
"utcnow_ts": "1607567271515475"
}
}
[02:27:51.526] Invocation finished in 1h54m53.2092635s with status SUCCEEDED