[09:42:51.192] New invocation is queued and will start shortly
[09:42:54.437] Starting the invocation (attempt 1)
[09:42:54.501] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:42:54.501] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:42:54.501] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9063159930328921504",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"96dbb3bc6a095b4e908869b60b7a673f781ef325\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9063159930328921504",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"gitiles_ref:refs/heads/master"
]
}
[09:42:55.550] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1572860574736774",
"id": "8897729865944188528",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96dbb3bc6a095b4e908869b60b7a673f781ef325\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572860575326866",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15113",
"builder:Windows deterministic",
"buildset:commit/git/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063159930328921504",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8897729865944188528/+/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": "1572860575326975",
"url": "https://ci.chromium.org/b/8897729865944188528",
"utcnow_ts": "1572860575537133"
}
}
[09:42:55.550] Task URL: https://ci.chromium.org/b/8897729865944188528
[09:42:55.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:2:0) after 1m0s
[09:43:55.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:2:0)
[09:43:55.605] Timer tick, asking Buildbucket for the build status
[09:43:55.831] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:55.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:3:0) after 1m0s
[09:44:55.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:3:0)
[09:44:55.851] Timer tick, asking Buildbucket for the build status
[09:44:56.273] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:56.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:4:0) after 1m0s
[09:45:56.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:4:0)
[09:45:56.336] Timer tick, asking Buildbucket for the build status
[09:45:56.917] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:56.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:5:0) after 1m0s
[09:46:56.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:5:0)
[09:46:56.951] Timer tick, asking Buildbucket for the build status
[09:46:58.214] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:58.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:6:0) after 1m0s
[09:47:58.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:6:0)
[09:47:58.298] Timer tick, asking Buildbucket for the build status
[09:47:58.602] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:58.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:7:0) after 1m0s
[09:48:58.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:7:0)
[09:48:58.664] Timer tick, asking Buildbucket for the build status
[09:48:59.415] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:59.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:8:0) after 1m0s
[09:49:59.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:8:0)
[09:49:59.537] Timer tick, asking Buildbucket for the build status
[09:49:59.979] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:59.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:9:0) after 1m0s
[09:51:00.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:9:0)
[09:51:00.137] Timer tick, asking Buildbucket for the build status
[09:51:02.293] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:02.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:10:0) after 1m0s
[09:52:02.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:10:0)
[09:52:02.334] Timer tick, asking Buildbucket for the build status
[09:52:02.481] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:02.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:11:0) after 1m0s
[09:53:02.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:11:0)
[09:53:02.539] Timer tick, asking Buildbucket for the build status
[09:53:03.352] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:03.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:12:0) after 1m0s
[09:54:03.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:12:0)
[09:54:03.392] Timer tick, asking Buildbucket for the build status
[09:54:05.693] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:05.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:13:0) after 1m0s
[09:55:05.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:13:0)
[09:55:05.715] Timer tick, asking Buildbucket for the build status
[09:55:06.107] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:06.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:14:0) after 1m0s
[09:56:06.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:14:0)
[09:56:06.202] Timer tick, asking Buildbucket for the build status
[09:56:07.550] Build 8897729865944188528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:07.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:15:0) after 1m0s
[09:56:31.457] Received PubSub notification, asking Buildbucket for the build status
[09:56:32.437] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:07.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:15:0)
[09:57:07.590] Timer tick, asking Buildbucket for the build status
[09:57:08.099] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:08.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:17:0) after 1m0s
[09:58:08.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:17:0)
[09:58:08.107] Timer tick, asking Buildbucket for the build status
[09:58:08.647] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:08.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:18:0) after 1m0s
[09:59:08.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:18:0)
[09:59:08.688] Timer tick, asking Buildbucket for the build status
[09:59:09.046] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:09.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:19:0) after 1m0s
[10:00:09.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:19:0)
[10:00:09.134] Timer tick, asking Buildbucket for the build status
[10:00:09.413] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:09.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:20:0) after 1m0s
[10:01:09.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:20:0)
[10:01:09.487] Timer tick, asking Buildbucket for the build status
[10:01:09.641] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:09.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:21:0) after 1m0s
[10:02:09.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:21:0)
[10:02:09.735] Timer tick, asking Buildbucket for the build status
[10:02:10.616] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:10.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:22:0) after 1m0s
[10:03:10.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:22:0)
[10:03:10.704] Timer tick, asking Buildbucket for the build status
[10:03:14.496] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:14.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:23:0) after 1m0s
[10:04:14.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:23:0)
[10:04:14.554] Timer tick, asking Buildbucket for the build status
[10:04:16.778] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:16.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:24:0) after 1m0s
[10:05:16.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:24:0)
[10:05:16.831] Timer tick, asking Buildbucket for the build status
[10:05:19.611] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:19.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:25:0) after 1m0s
[10:06:19.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:25:0)
[10:06:19.707] Timer tick, asking Buildbucket for the build status
[10:06:20.629] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:20.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:26:0) after 1m0s
[10:07:20.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:26:0)
[10:07:20.702] Timer tick, asking Buildbucket for the build status
[10:07:24.183] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:24.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:27:0) after 1m0s
[10:08:24.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:27:0)
[10:08:24.468] Timer tick, asking Buildbucket for the build status
[10:08:28.548] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:28.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:28:0) after 1m0s
[10:09:28.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:28:0)
[10:09:28.629] Timer tick, asking Buildbucket for the build status
[10:09:29.575] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:29.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:29:0) after 1m0s
[10:10:29.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:29:0)
[10:10:29.629] Timer tick, asking Buildbucket for the build status
[10:10:31.514] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:31.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:30:0) after 1m0s
[10:11:31.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:30:0)
[10:11:31.552] Timer tick, asking Buildbucket for the build status
[10:11:32.251] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:32.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:31:0) after 1m0s
[10:12:32.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:31:0)
[10:12:32.284] Timer tick, asking Buildbucket for the build status
[10:12:33.026] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:33.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:32:0) after 1m0s
[10:13:33.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:32:0)
[10:13:33.056] Timer tick, asking Buildbucket for the build status
[10:13:33.524] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:33.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:33:0) after 1m0s
[10:14:33.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:33:0)
[10:14:33.618] Timer tick, asking Buildbucket for the build status
[10:14:33.861] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:34:0) after 1m0s
[10:15:33.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:34:0)
[10:15:33.894] Timer tick, asking Buildbucket for the build status
[10:15:34.320] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:34.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:35:0) after 1m0s
[10:16:34.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:35:0)
[10:16:34.363] Timer tick, asking Buildbucket for the build status
[10:16:34.811] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:34.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:36:0) after 1m0s
[10:17:34.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:36:0)
[10:17:34.859] Timer tick, asking Buildbucket for the build status
[10:17:35.096] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:35.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:37:0) after 1m0s
[10:18:35.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:37:0)
[10:18:35.122] Timer tick, asking Buildbucket for the build status
[10:18:35.523] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:35.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:38:0) after 1m0s
[10:19:35.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:38:0)
[10:19:35.641] Timer tick, asking Buildbucket for the build status
[10:19:36.013] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:39:0) after 1m0s
[10:20:36.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:39:0)
[10:20:36.045] Timer tick, asking Buildbucket for the build status
[10:20:36.280] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:40:0) after 1m0s
[10:21:36.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:40:0)
[10:21:36.307] Timer tick, asking Buildbucket for the build status
[10:21:37.712] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:37.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:41:0) after 1m0s
[10:22:37.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:41:0)
[10:22:37.748] Timer tick, asking Buildbucket for the build status
[10:22:39.132] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:39.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:42:0) after 1m0s
[10:23:39.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:42:0)
[10:23:39.192] Timer tick, asking Buildbucket for the build status
[10:23:40.188] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:40.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:43:0) after 1m0s
[10:24:40.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:43:0)
[10:24:40.269] Timer tick, asking Buildbucket for the build status
[10:24:41.139] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:41.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:44:0) after 1m0s
[10:25:41.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:44:0)
[10:25:41.172] Timer tick, asking Buildbucket for the build status
[10:25:44.159] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:45:0) after 1m0s
[10:26:44.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:45:0)
[10:26:44.200] Timer tick, asking Buildbucket for the build status
[10:26:45.650] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:45.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:46:0) after 1m0s
[10:27:45.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:46:0)
[10:27:45.676] Timer tick, asking Buildbucket for the build status
[10:27:45.949] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:45.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:47:0) after 1m0s
[10:28:45.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:47:0)
[10:28:45.973] Timer tick, asking Buildbucket for the build status
[10:28:47.053] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:47.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:48:0) after 1m0s
[10:29:47.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:48:0)
[10:29:47.048] Timer tick, asking Buildbucket for the build status
[10:29:50.673] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:50.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:49:0) after 1m0s
[10:30:50.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:49:0)
[10:30:50.812] Timer tick, asking Buildbucket for the build status
[10:30:51.631] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:51.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:50:0) after 1m0s
[10:31:51.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:50:0)
[10:31:51.656] Timer tick, asking Buildbucket for the build status
[10:31:52.242] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:52.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:51:0) after 1m0s
[10:32:52.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:51:0)
[10:32:52.590] Timer tick, asking Buildbucket for the build status
[10:32:52.828] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:52.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:52:0) after 1m0s
[10:33:53.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:52:0)
[10:33:53.197] Timer tick, asking Buildbucket for the build status
[10:33:53.376] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:53:0) after 1m0s
[10:34:53.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:53:0)
[10:34:53.429] Timer tick, asking Buildbucket for the build status
[10:35:00.726] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:00.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:54:0) after 1m0s
[10:36:01.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:54:0)
[10:36:01.009] Timer tick, asking Buildbucket for the build status
[10:36:01.553] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:01.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:55:0) after 1m0s
[10:37:01.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:55:0)
[10:37:01.567] Timer tick, asking Buildbucket for the build status
[10:37:01.952] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:01.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:56:0) after 1m0s
[10:38:01.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:56:0)
[10:38:01.994] Timer tick, asking Buildbucket for the build status
[10:38:03.400] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:03.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:57:0) after 1m0s
[10:39:03.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:57:0)
[10:39:03.431] Timer tick, asking Buildbucket for the build status
[10:39:04.036] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:04.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:58:0) after 1m0s
[10:40:05.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:58:0)
[10:40:05.558] Timer tick, asking Buildbucket for the build status
[10:40:09.386] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:09.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:59:0) after 1m0s
[10:41:09.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:59:0)
[10:41:09.516] Timer tick, asking Buildbucket for the build status
[10:41:10.583] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:10.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:60:0) after 1m0s
[10:42:10.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:60:0)
[10:42:10.649] Timer tick, asking Buildbucket for the build status
[10:42:11.468] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:11.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:61:0) after 1m0s
[10:43:11.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:61:0)
[10:43:11.449] Timer tick, asking Buildbucket for the build status
[10:43:11.781] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:11.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:62:0) after 1m0s
[10:44:11.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:62:0)
[10:44:11.868] Timer tick, asking Buildbucket for the build status
[10:44:12.513] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:12.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:63:0) after 1m0s
[10:45:12.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:63:0)
[10:45:12.516] Timer tick, asking Buildbucket for the build status
[10:45:12.918] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:64:0) after 1m0s
[10:46:12.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:64:0)
[10:46:12.949] Timer tick, asking Buildbucket for the build status
[10:46:13.261] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:13.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:65:0) after 1m0s
[10:47:13.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:65:0)
[10:47:13.428] Timer tick, asking Buildbucket for the build status
[10:47:15.773] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:15.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:66:0) after 1m0s
[10:48:15.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:66:0)
[10:48:15.851] Timer tick, asking Buildbucket for the build status
[10:48:19.199] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:19.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:67:0) after 1m0s
[10:49:19.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:67:0)
[10:49:19.346] Timer tick, asking Buildbucket for the build status
[10:49:19.567] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:19.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:68:0) after 1m0s
[10:50:19.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:68:0)
[10:50:19.596] Timer tick, asking Buildbucket for the build status
[10:50:20.374] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:20.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:69:0) after 1m0s
[10:51:20.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:69:0)
[10:51:20.408] Timer tick, asking Buildbucket for the build status
[10:51:20.819] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:20.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:70:0) after 1m0s
[10:52:20.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:70:0)
[10:52:20.841] Timer tick, asking Buildbucket for the build status
[10:52:21.367] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:21.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:71:0) after 1m0s
[10:53:21.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:71:0)
[10:53:21.392] Timer tick, asking Buildbucket for the build status
[10:53:21.973] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:21.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:72:0) after 1m0s
[10:54:21.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:72:0)
[10:54:21.995] Timer tick, asking Buildbucket for the build status
[10:54:25.056] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:25.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:73:0) after 1m0s
[10:55:25.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:73:0)
[10:55:25.633] Timer tick, asking Buildbucket for the build status
[10:55:26.884] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:26.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:74:0) after 1m0s
[10:56:26.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:74:0)
[10:56:26.873] Timer tick, asking Buildbucket for the build status
[10:56:28.809] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:28.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:75:0) after 1m0s
[10:57:29.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:75:0)
[10:57:29.144] Timer tick, asking Buildbucket for the build status
[10:57:29.404] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:29.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:76:0) after 1m0s
[10:58:29.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:76:0)
[10:58:29.739] Timer tick, asking Buildbucket for the build status
[10:58:29.965] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:29.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:77:0) after 1m0s
[10:59:30.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:77:0)
[10:59:30.297] Timer tick, asking Buildbucket for the build status
[10:59:31.202] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:78:0) after 1m0s
[11:00:31.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:78:0)
[11:00:31.203] Timer tick, asking Buildbucket for the build status
[11:00:31.348] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:31.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:79:0) after 1m0s
[11:01:31.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:79:0)
[11:01:31.387] Timer tick, asking Buildbucket for the build status
[11:01:31.867] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:31.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:80:0) after 1m0s
[11:02:31.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:80:0)
[11:02:31.991] Timer tick, asking Buildbucket for the build status
[11:02:34.677] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:34.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:81:0) after 1m0s
[11:03:34.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:81:0)
[11:03:34.836] Timer tick, asking Buildbucket for the build status
[11:03:40.409] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:40.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:82:0) after 1m0s
[11:04:40.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:82:0)
[11:04:40.693] Timer tick, asking Buildbucket for the build status
[11:04:40.926] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:40.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:83:0) after 1m0s
[11:05:41.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:83:0)
[11:05:41.113] Timer tick, asking Buildbucket for the build status
[11:05:41.484] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:41.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:84:0) after 1m0s
[11:06:41.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:84:0)
[11:06:41.526] Timer tick, asking Buildbucket for the build status
[11:06:42.814] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:42.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:85:0) after 1m0s
[11:07:42.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:85:0)
[11:07:42.836] Timer tick, asking Buildbucket for the build status
[11:07:45.392] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:45.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:86:0) after 1m0s
[11:08:45.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:86:0)
[11:08:45.514] Timer tick, asking Buildbucket for the build status
[11:08:46.323] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:46.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:87:0) after 1m0s
[11:09:46.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:87:0)
[11:09:46.381] Timer tick, asking Buildbucket for the build status
[11:09:47.333] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:47.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:88:0) after 1m0s
[11:10:47.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:88:0)
[11:10:47.371] Timer tick, asking Buildbucket for the build status
[11:10:48.830] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:48.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:89:0) after 1m0s
[11:11:48.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:89:0)
[11:11:48.914] Timer tick, asking Buildbucket for the build status
[11:11:49.766] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:49.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:90:0) after 1m0s
[11:12:49.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:90:0)
[11:12:49.796] Timer tick, asking Buildbucket for the build status
[11:12:50.025] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:50.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:91:0) after 1m0s
[11:13:50.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:91:0)
[11:13:50.131] Timer tick, asking Buildbucket for the build status
[11:13:50.355] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:50.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:92:0) after 1m0s
[11:14:50.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:92:0)
[11:14:50.473] Timer tick, asking Buildbucket for the build status
[11:14:51.129] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:51.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:93:0) after 1m0s
[11:15:51.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:93:0)
[11:15:51.210] Timer tick, asking Buildbucket for the build status
[11:15:51.545] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:51.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:94:0) after 1m0s
[11:16:51.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:94:0)
[11:16:51.618] Timer tick, asking Buildbucket for the build status
[11:16:53.014] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:53.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:95:0) after 1m0s
[11:17:53.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:95:0)
[11:17:53.040] Timer tick, asking Buildbucket for the build status
[11:17:54.043] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:54.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:96:0) after 1m0s
[11:18:54.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:96:0)
[11:18:54.088] Timer tick, asking Buildbucket for the build status
[11:18:57.394] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:57.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:97:0) after 1m0s
[11:19:57.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:97:0)
[11:19:57.511] Timer tick, asking Buildbucket for the build status
[11:19:59.662] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:59.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:98:0) after 1m0s
[11:20:59.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:98:0)
[11:20:59.824] Timer tick, asking Buildbucket for the build status
[11:21:00.111] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:00.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:99:0) after 1m0s
[11:22:00.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:99:0)
[11:22:00.167] Timer tick, asking Buildbucket for the build status
[11:22:00.461] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:00.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:100:0) after 1m0s
[11:23:00.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:100:0)
[11:23:00.579] Timer tick, asking Buildbucket for the build status
[11:23:01.785] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:01.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:101:0) after 1m0s
[11:24:01.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:101:0)
[11:24:01.824] Timer tick, asking Buildbucket for the build status
[11:24:04.521] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:04.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:102:0) after 1m0s
[11:25:04.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:102:0)
[11:25:04.546] Timer tick, asking Buildbucket for the build status
[11:25:05.796] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:103:0) after 1m0s
[11:26:05.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:103:0)
[11:26:05.827] Timer tick, asking Buildbucket for the build status
[11:26:09.568] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:09.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:104:0) after 1m0s
[11:27:09.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:104:0)
[11:27:09.750] Timer tick, asking Buildbucket for the build status
[11:27:11.039] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:11.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:105:0) after 1m0s
[11:28:11.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:105:0)
[11:28:11.253] Timer tick, asking Buildbucket for the build status
[11:28:11.556] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:11.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:106:0) after 1m0s
[11:29:11.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:106:0)
[11:29:11.620] Timer tick, asking Buildbucket for the build status
[11:29:12.173] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:12.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:107:0) after 1m0s
[11:30:12.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:107:0)
[11:30:12.346] Timer tick, asking Buildbucket for the build status
[11:30:13.675] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:13.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:108:0) after 1m0s
[11:31:13.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:108:0)
[11:31:13.817] Timer tick, asking Buildbucket for the build status
[11:31:14.114] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:14.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:109:0) after 1m0s
[11:32:14.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:109:0)
[11:32:14.383] Timer tick, asking Buildbucket for the build status
[11:32:14.960] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:14.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:110:0) after 1m0s
[11:33:15.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:110:0)
[11:33:15.044] Timer tick, asking Buildbucket for the build status
[11:33:15.409] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:111:0) after 1m0s
[11:34:16.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:111:0)
[11:34:16.229] Timer tick, asking Buildbucket for the build status
[11:34:16.774] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:16.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:112:0) after 1m0s
[11:35:17.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:112:0)
[11:35:17.269] Timer tick, asking Buildbucket for the build status
[11:35:17.655] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:17.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:113:0) after 1m0s
[11:36:17.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:113:0)
[11:36:17.893] Timer tick, asking Buildbucket for the build status
[11:36:18.306] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:18.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:114:0) after 1m0s
[11:37:18.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:114:0)
[11:37:18.724] Timer tick, asking Buildbucket for the build status
[11:37:21.348] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:21.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:115:0) after 1m0s
[11:38:21.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:115:0)
[11:38:21.399] Timer tick, asking Buildbucket for the build status
[11:38:23.660] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:23.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:116:0) after 1m0s
[11:39:24.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:116:0)
[11:39:24.058] Timer tick, asking Buildbucket for the build status
[11:39:24.520] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:24.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:117:0) after 1m0s
[11:40:24.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:117:0)
[11:40:24.771] Timer tick, asking Buildbucket for the build status
[11:40:25.615] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:25.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:118:0) after 1m0s
[11:41:25.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:118:0)
[11:41:25.928] Timer tick, asking Buildbucket for the build status
[11:41:28.641] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:28.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:119:0) after 1m0s
[11:42:28.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:119:0)
[11:42:28.740] Timer tick, asking Buildbucket for the build status
[11:42:28.995] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:120:0) after 1m0s
[11:43:29.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:120:0)
[11:43:29.055] Timer tick, asking Buildbucket for the build status
[11:43:29.409] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:29.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:121:0) after 1m0s
[11:44:29.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:121:0)
[11:44:29.497] Timer tick, asking Buildbucket for the build status
[11:44:30.004] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:30.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:122:0) after 1m0s
[11:45:30.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:122:0)
[11:45:30.210] Timer tick, asking Buildbucket for the build status
[11:45:30.513] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:30.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:123:0) after 1m0s
[11:46:30.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:123:0)
[11:46:30.562] Timer tick, asking Buildbucket for the build status
[11:46:31.709] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:31.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:124:0) after 1m0s
[11:47:31.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:124:0)
[11:47:31.706] Timer tick, asking Buildbucket for the build status
[11:47:32.688] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:32.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:125:0) after 1m0s
[11:48:32.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:125:0)
[11:48:32.714] Timer tick, asking Buildbucket for the build status
[11:48:33.013] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:33.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:126:0) after 1m0s
[11:49:33.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:126:0)
[11:49:33.043] Timer tick, asking Buildbucket for the build status
[11:49:37.008] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:37.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:127:0) after 1m0s
[11:50:37.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:127:0)
[11:50:37.051] Timer tick, asking Buildbucket for the build status
[11:50:37.222] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:37.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:128:0) after 1m0s
[11:51:37.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:128:0)
[11:51:37.353] Timer tick, asking Buildbucket for the build status
[11:51:38.166] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:38.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:129:0) after 1m0s
[11:52:38.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:129:0)
[11:52:38.236] Timer tick, asking Buildbucket for the build status
[11:52:38.507] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:38.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:130:0) after 1m0s
[11:53:38.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:130:0)
[11:53:38.577] Timer tick, asking Buildbucket for the build status
[11:53:39.248] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:39.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:131:0) after 1m0s
[11:54:39.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:131:0)
[11:54:39.306] Timer tick, asking Buildbucket for the build status
[11:54:40.445] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:40.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:132:0) after 1m0s
[11:55:40.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:132:0)
[11:55:40.472] Timer tick, asking Buildbucket for the build status
[11:55:40.710] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:40.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:133:0) after 1m0s
[11:56:40.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:133:0)
[11:56:40.737] Timer tick, asking Buildbucket for the build status
[11:56:41.410] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:41.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:134:0) after 1m0s
[11:57:41.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:134:0)
[11:57:41.484] Timer tick, asking Buildbucket for the build status
[11:57:43.165] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:43.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:135:0) after 1m0s
[11:58:43.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:135:0)
[11:58:43.248] Timer tick, asking Buildbucket for the build status
[11:58:47.074] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:47.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:136:0) after 1m0s
[11:59:47.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:136:0)
[11:59:47.345] Timer tick, asking Buildbucket for the build status
[11:59:47.632] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:47.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:137:0) after 1m0s
[12:00:47.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:137:0)
[12:00:47.644] Timer tick, asking Buildbucket for the build status
[12:00:47.837] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:47.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:138:0) after 1m0s
[12:01:47.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:138:0)
[12:01:47.866] Timer tick, asking Buildbucket for the build status
[12:01:48.343] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:48.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:139:0) after 1m0s
[12:02:48.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:139:0)
[12:02:48.373] Timer tick, asking Buildbucket for the build status
[12:02:51.727] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:51.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:140:0) after 1m0s
[12:03:51.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:140:0)
[12:03:51.834] Timer tick, asking Buildbucket for the build status
[12:03:52.387] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:52.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:141:0) after 1m0s
[12:04:52.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:141:0)
[12:04:52.686] Timer tick, asking Buildbucket for the build status
[12:04:54.812] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:54.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:142:0) after 1m0s
[12:05:54.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:142:0)
[12:05:54.806] Timer tick, asking Buildbucket for the build status
[12:05:55.208] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:55.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:143:0) after 1m0s
[12:06:55.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:143:0)
[12:06:55.234] Timer tick, asking Buildbucket for the build status
[12:06:58.279] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:58.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:144:0) after 1m0s
[12:07:58.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:144:0)
[12:07:58.314] Timer tick, asking Buildbucket for the build status
[12:07:58.753] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:58.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:145:0) after 1m0s
[12:08:58.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:145:0)
[12:08:58.786] Timer tick, asking Buildbucket for the build status
[12:08:59.040] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:59.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:146:0) after 1m0s
[12:09:59.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:146:0)
[12:09:59.111] Timer tick, asking Buildbucket for the build status
[12:10:01.052] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:01.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:147:0) after 1m0s
[12:11:01.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:147:0)
[12:11:01.071] Timer tick, asking Buildbucket for the build status
[12:11:01.653] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:01.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:148:0) after 1m0s
[12:12:01.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:148:0)
[12:12:01.700] Timer tick, asking Buildbucket for the build status
[12:12:03.034] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:03.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:149:0) after 1m0s
[12:13:03.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:149:0)
[12:13:03.062] Timer tick, asking Buildbucket for the build status
[12:13:04.125] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:04.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:150:0) after 1m0s
[12:14:04.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:150:0)
[12:14:04.214] Timer tick, asking Buildbucket for the build status
[12:14:04.711] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:04.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:151:0) after 1m0s
[12:15:04.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:151:0)
[12:15:04.904] Timer tick, asking Buildbucket for the build status
[12:15:07.083] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:152:0) after 1m0s
[12:16:07.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:152:0)
[12:16:07.138] Timer tick, asking Buildbucket for the build status
[12:16:07.419] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:07.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:153:0) after 1m0s
[12:17:07.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:153:0)
[12:17:07.448] Timer tick, asking Buildbucket for the build status
[12:17:08.186] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:08.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:154:0) after 1m0s
[12:18:08.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:154:0)
[12:18:08.303] Timer tick, asking Buildbucket for the build status
[12:18:08.780] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:08.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:155:0) after 1m0s
[12:19:08.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:155:0)
[12:19:08.814] Timer tick, asking Buildbucket for the build status
[12:19:09.597] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:156:0) after 1m0s
[12:20:09.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:156:0)
[12:20:09.633] Timer tick, asking Buildbucket for the build status
[12:20:12.421] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:12.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:157:0) after 1m0s
[12:21:12.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:157:0)
[12:21:12.497] Timer tick, asking Buildbucket for the build status
[12:21:12.688] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:12.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:158:0) after 1m0s
[12:22:12.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:158:0)
[12:22:12.713] Timer tick, asking Buildbucket for the build status
[12:22:13.027] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:13.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:159:0) after 1m0s
[12:23:13.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:159:0)
[12:23:13.079] Timer tick, asking Buildbucket for the build status
[12:23:13.608] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:13.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:160:0) after 1m0s
[12:24:13.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:160:0)
[12:24:13.672] Timer tick, asking Buildbucket for the build status
[12:24:14.617] Build 8897729865944188528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:14.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063159930328921504:161:0) after 1m0s
[12:24:50.907] Received PubSub notification, asking Buildbucket for the build status
[12:24:51.160] Build 8897729865944188528: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:24:51.160] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1572870289120118",
"created_by": "project:chromium",
"created_ts": "1572860574736774",
"failure_reason": "BUILD_FAILURE",
"id": "8897729865944188528",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96dbb3bc6a095b4e908869b60b7a673f781ef325\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-565u\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15113, \"got_angle_revision\": \"6c7208f93d6ecda3ad2515ea02e3dd5985a9dafe\", \"got_dawn_revision\": \"314fd3513d04fdc7412df0b6c7defc7b79356e8d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"96dbb3bc6a095b4e908869b60b7a673f781ef325\", \"got_revision_cp\": \"refs/heads/master@{#712063}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"aaa64b76c0b40c2958a18cfdc623157c8c6e1b7d\", \"got_v8_revision\": \"53ede12e867e12ed12a5d257cf69bd2c6abe9ab9\", \"got_v8_revision_cp\": \"refs/heads/8.0.137@{#1}\", \"got_webrtc_revision\": \"8846c8af8511b505c4b61cefd4db49d15871baa7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29675}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96dbb3bc6a095b4e908869b60b7a673f781ef325\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-565u\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1572861389766497",
"status": "COMPLETED",
"status_changed_ts": "1572861390865116",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15113",
"builder:Windows deterministic",
"buildset:commit/git/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96dbb3bc6a095b4e908869b60b7a673f781ef325",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063159930328921504",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8897729865944188528/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:484e9d8837538810",
"user_agent:luci-scheduler"
],
"updated_ts": "1572870290054207",
"url": "https://ci.chromium.org/b/8897729865944188528",
"utcnow_ts": "1572870291139954"
}
}
[12:24:51.160] Invocation finished in 2h41m59.988552232s with status FAILED