[17:43:54.763] New invocation is queued and will start shortly
[17:43:55.854] Starting the invocation (attempt 1)
[17:43:55.925] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:55.925] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:55.925] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061770710190989472",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"43a60f8d83ed3c71709e0256083d90bac95bea65\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9061770710190989472",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/43a60f8d83ed3c71709e0256083d90bac95bea65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43a60f8d83ed3c71709e0256083d90bac95bea65",
"gitiles_ref:refs/heads/master"
]
}
[17:43:57.431] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574185436336822",
"id": "8896340647866691248",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43a60f8d83ed3c71709e0256083d90bac95bea65\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574185437122913",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15244",
"builder:Windows deterministic",
"buildset:commit/git/43a60f8d83ed3c71709e0256083d90bac95bea65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43a60f8d83ed3c71709e0256083d90bac95bea65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061770710190989472",
"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/8896340647866691248/+/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": "1574185437123090",
"url": "https://ci.chromium.org/b/8896340647866691248",
"utcnow_ts": "1574185437415818"
}
}
[17:43:57.431] Task URL: https://ci.chromium.org/b/8896340647866691248
[17:43:57.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:2:0) after 1m0s
[17:44:57.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:2:0)
[17:44:57.511] Timer tick, asking Buildbucket for the build status
[17:44:58.243] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:58.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:3:0) after 1m0s
[17:45:58.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:3:0)
[17:45:58.382] Timer tick, asking Buildbucket for the build status
[17:45:58.603] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:58.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:4:0) after 1m0s
[17:46:58.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:4:0)
[17:46:58.771] Timer tick, asking Buildbucket for the build status
[17:46:58.986] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:58.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:5:0) after 1m0s
[17:47:59.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:5:0)
[17:47:59.035] Timer tick, asking Buildbucket for the build status
[17:47:59.220] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:59.220] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:6:0) after 1m0s
[17:48:59.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:6:0)
[17:48:59.313] Timer tick, asking Buildbucket for the build status
[17:49:00.128] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:00.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:7:0) after 1m0s
[17:50:00.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:7:0)
[17:50:00.205] Timer tick, asking Buildbucket for the build status
[17:50:00.649] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:00.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:8:0) after 1m0s
[17:51:00.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:8:0)
[17:51:00.739] Timer tick, asking Buildbucket for the build status
[17:51:01.781] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:01.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:9:0) after 1m0s
[17:52:01.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:9:0)
[17:52:01.863] Timer tick, asking Buildbucket for the build status
[17:52:02.201] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:02.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:10:0) after 1m0s
[17:53:02.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:10:0)
[17:53:02.286] Timer tick, asking Buildbucket for the build status
[17:53:02.614] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:02.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:11:0) after 1m0s
[17:54:02.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:11:0)
[17:54:02.649] Timer tick, asking Buildbucket for the build status
[17:54:02.817] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:02.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:12:0) after 1m0s
[17:55:02.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:12:0)
[17:55:02.944] Timer tick, asking Buildbucket for the build status
[17:55:03.093] Build 8896340647866691248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:13:0) after 1m0s
[17:55:47.208] Received PubSub notification, asking Buildbucket for the build status
[17:55:48.131] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:03.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:13:0)
[17:56:03.134] Timer tick, asking Buildbucket for the build status
[17:56:03.632] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:03.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:15:0) after 1m0s
[17:57:03.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:15:0)
[17:57:03.655] Timer tick, asking Buildbucket for the build status
[17:57:03.859] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:03.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:16:0) after 1m0s
[17:58:03.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:16:0)
[17:58:03.881] Timer tick, asking Buildbucket for the build status
[17:58:04.196] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:04.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:17:0) after 1m0s
[17:59:04.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:17:0)
[17:59:04.398] Timer tick, asking Buildbucket for the build status
[17:59:04.629] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:04.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:18:0) after 1m0s
[18:00:04.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:18:0)
[18:00:04.718] Timer tick, asking Buildbucket for the build status
[18:00:04.925] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:04.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:19:0) after 1m0s
[18:01:05.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:19:0)
[18:01:05.159] Timer tick, asking Buildbucket for the build status
[18:01:05.762] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:05.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:20:0) after 1m0s
[18:02:05.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:20:0)
[18:02:05.938] Timer tick, asking Buildbucket for the build status
[18:02:06.557] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:06.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:21:0) after 1m0s
[18:03:06.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:21:0)
[18:03:06.815] Timer tick, asking Buildbucket for the build status
[18:03:07.033] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:07.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:22:0) after 1m0s
[18:04:07.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:22:0)
[18:04:07.287] Timer tick, asking Buildbucket for the build status
[18:04:07.595] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:07.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:23:0) after 1m0s
[18:05:07.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:23:0)
[18:05:07.659] Timer tick, asking Buildbucket for the build status
[18:05:08.413] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:08.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:24:0) after 1m0s
[18:06:08.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:24:0)
[18:06:08.665] Timer tick, asking Buildbucket for the build status
[18:06:09.692] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:09.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:25:0) after 1m0s
[18:07:09.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:25:0)
[18:07:09.868] Timer tick, asking Buildbucket for the build status
[18:07:10.057] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:10.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:26:0) after 1m0s
[18:08:10.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:26:0)
[18:08:10.201] Timer tick, asking Buildbucket for the build status
[18:08:10.513] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:27:0) after 1m0s
[18:09:10.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:27:0)
[18:09:10.597] Timer tick, asking Buildbucket for the build status
[18:09:10.965] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:10.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:28:0) after 1m0s
[18:10:11.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:28:0)
[18:10:11.106] Timer tick, asking Buildbucket for the build status
[18:10:11.722] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:11.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:29:0) after 1m0s
[18:11:11.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:29:0)
[18:11:11.729] Timer tick, asking Buildbucket for the build status
[18:11:12.269] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:12.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:30:0) after 1m0s
[18:12:12.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:30:0)
[18:12:12.378] Timer tick, asking Buildbucket for the build status
[18:12:13.072] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:13.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:31:0) after 1m0s
[18:13:13.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:31:0)
[18:13:13.099] Timer tick, asking Buildbucket for the build status
[18:13:14.123] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:14.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:32:0) after 1m0s
[18:14:14.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:32:0)
[18:14:14.186] Timer tick, asking Buildbucket for the build status
[18:14:14.365] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:14.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:33:0) after 1m0s
[18:15:14.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:33:0)
[18:15:14.449] Timer tick, asking Buildbucket for the build status
[18:15:14.798] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:14.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:34:0) after 1m0s
[18:16:14.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:34:0)
[18:16:14.973] Timer tick, asking Buildbucket for the build status
[18:16:15.227] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:35:0) after 1m0s
[18:17:15.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:35:0)
[18:17:15.265] Timer tick, asking Buildbucket for the build status
[18:17:16.025] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:36:0) after 1m0s
[18:18:16.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:36:0)
[18:18:16.143] Timer tick, asking Buildbucket for the build status
[18:18:16.449] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:16.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:37:0) after 1m0s
[18:19:16.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:37:0)
[18:19:16.555] Timer tick, asking Buildbucket for the build status
[18:19:16.695] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:16.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:38:0) after 1m0s
[18:20:16.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:38:0)
[18:20:16.742] Timer tick, asking Buildbucket for the build status
[18:20:17.188] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:39:0) after 1m0s
[18:21:17.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:39:0)
[18:21:17.298] Timer tick, asking Buildbucket for the build status
[18:21:17.655] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:17.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:40:0) after 1m0s
[18:22:17.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:40:0)
[18:22:17.800] Timer tick, asking Buildbucket for the build status
[18:22:17.951] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:17.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:41:0) after 1m0s
[18:23:17.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:41:0)
[18:23:17.962] Timer tick, asking Buildbucket for the build status
[18:23:18.287] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:18.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:42:0) after 1m0s
[18:24:18.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:42:0)
[18:24:18.514] Timer tick, asking Buildbucket for the build status
[18:24:18.752] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:18.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:43:0) after 1m0s
[18:25:18.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:43:0)
[18:25:18.820] Timer tick, asking Buildbucket for the build status
[18:25:19.014] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:19.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:44:0) after 1m0s
[18:26:19.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:44:0)
[18:26:19.065] Timer tick, asking Buildbucket for the build status
[18:26:19.232] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:19.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:45:0) after 1m0s
[18:27:19.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:45:0)
[18:27:19.427] Timer tick, asking Buildbucket for the build status
[18:27:19.964] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:19.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:46:0) after 1m0s
[18:28:20.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:46:0)
[18:28:20.041] Timer tick, asking Buildbucket for the build status
[18:28:20.812] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:20.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:47:0) after 1m0s
[18:29:20.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:47:0)
[18:29:20.843] Timer tick, asking Buildbucket for the build status
[18:29:21.011] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:21.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:48:0) after 1m0s
[18:30:21.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:48:0)
[18:30:21.085] Timer tick, asking Buildbucket for the build status
[18:30:21.400] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:21.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:49:0) after 1m0s
[18:31:21.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:49:0)
[18:31:21.434] Timer tick, asking Buildbucket for the build status
[18:31:21.845] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:21.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:50:0) after 1m0s
[18:32:22.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:50:0)
[18:32:22.023] Timer tick, asking Buildbucket for the build status
[18:32:22.216] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:22.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:51:0) after 1m0s
[18:33:22.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:51:0)
[18:33:22.303] Timer tick, asking Buildbucket for the build status
[18:33:23.031] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:23.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:52:0) after 1m0s
[18:34:23.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:52:0)
[18:34:23.197] Timer tick, asking Buildbucket for the build status
[18:34:23.430] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:23.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:53:0) after 1m0s
[18:35:23.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:53:0)
[18:35:23.628] Timer tick, asking Buildbucket for the build status
[18:35:24.657] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:24.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:54:0) after 1m0s
[18:36:24.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:54:0)
[18:36:24.889] Timer tick, asking Buildbucket for the build status
[18:36:25.190] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:55:0) after 1m0s
[18:37:25.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:55:0)
[18:37:25.417] Timer tick, asking Buildbucket for the build status
[18:37:26.207] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:26.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:56:0) after 1m0s
[18:38:26.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:56:0)
[18:38:26.416] Timer tick, asking Buildbucket for the build status
[18:38:26.812] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:26.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:57:0) after 1m0s
[18:39:26.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:57:0)
[18:39:26.985] Timer tick, asking Buildbucket for the build status
[18:39:27.943] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:27.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:58:0) after 1m0s
[18:40:28.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:58:0)
[18:40:28.180] Timer tick, asking Buildbucket for the build status
[18:40:28.642] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:59:0) after 1m0s
[18:41:28.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:59:0)
[18:41:28.831] Timer tick, asking Buildbucket for the build status
[18:41:30.666] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:30.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:60:0) after 1m0s
[18:42:30.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:60:0)
[18:42:30.948] Timer tick, asking Buildbucket for the build status
[18:42:31.625] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:61:0) after 1m0s
[18:43:32.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:61:0)
[18:43:32.009] Timer tick, asking Buildbucket for the build status
[18:43:37.177] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:37.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:62:0) after 1m0s
[18:44:37.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:62:0)
[18:44:37.161] Timer tick, asking Buildbucket for the build status
[18:44:37.809] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:37.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:63:0) after 1m0s
[18:45:37.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:63:0)
[18:45:37.832] Timer tick, asking Buildbucket for the build status
[18:45:40.205] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:64:0) after 1m0s
[18:46:40.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:64:0)
[18:46:40.410] Timer tick, asking Buildbucket for the build status
[18:46:40.750] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:40.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:65:0) after 1m0s
[18:47:40.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:65:0)
[18:47:40.782] Timer tick, asking Buildbucket for the build status
[18:47:41.104] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:41.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:66:0) after 1m0s
[18:48:41.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:66:0)
[18:48:41.312] Timer tick, asking Buildbucket for the build status
[18:48:41.459] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:41.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:67:0) after 1m0s
[18:49:41.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:67:0)
[18:49:41.515] Timer tick, asking Buildbucket for the build status
[18:49:42.066] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:42.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:68:0) after 1m0s
[18:50:42.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:68:0)
[18:50:42.168] Timer tick, asking Buildbucket for the build status
[18:50:42.500] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:42.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:69:0) after 1m0s
[18:51:42.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:69:0)
[18:51:42.635] Timer tick, asking Buildbucket for the build status
[18:51:42.801] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:42.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:70:0) after 1m0s
[18:52:43.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:70:0)
[18:52:43.452] Timer tick, asking Buildbucket for the build status
[18:52:43.746] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:71:0) after 1m0s
[18:53:43.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:71:0)
[18:53:43.820] Timer tick, asking Buildbucket for the build status
[18:53:44.200] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:44.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:72:0) after 1m0s
[18:54:44.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:72:0)
[18:54:44.457] Timer tick, asking Buildbucket for the build status
[18:54:44.727] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:44.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:73:0) after 1m0s
[18:55:45.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:73:0)
[18:55:45.135] Timer tick, asking Buildbucket for the build status
[18:55:45.914] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:45.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:74:0) after 1m0s
[18:56:46.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:74:0)
[18:56:46.044] Timer tick, asking Buildbucket for the build status
[18:56:46.272] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:46.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:75:0) after 1m0s
[18:57:46.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:75:0)
[18:57:46.324] Timer tick, asking Buildbucket for the build status
[18:57:46.645] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:46.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:76:0) after 1m0s
[18:58:46.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:76:0)
[18:58:46.800] Timer tick, asking Buildbucket for the build status
[18:58:47.074] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:47.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:77:0) after 1m0s
[18:59:47.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:77:0)
[18:59:47.413] Timer tick, asking Buildbucket for the build status
[18:59:48.012] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:48.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:78:0) after 1m0s
[19:00:48.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:78:0)
[19:00:48.266] Timer tick, asking Buildbucket for the build status
[19:00:48.457] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:48.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:79:0) after 1m0s
[19:01:48.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:79:0)
[19:01:48.738] Timer tick, asking Buildbucket for the build status
[19:01:49.410] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:49.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:80:0) after 1m0s
[19:02:49.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:80:0)
[19:02:49.663] Timer tick, asking Buildbucket for the build status
[19:02:50.440] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:50.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:81:0) after 1m0s
[19:03:50.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:81:0)
[19:03:50.738] Timer tick, asking Buildbucket for the build status
[19:03:50.934] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:50.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:82:0) after 1m0s
[19:04:51.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:82:0)
[19:04:51.384] Timer tick, asking Buildbucket for the build status
[19:04:51.649] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:51.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:83:0) after 1m0s
[19:05:51.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:83:0)
[19:05:51.789] Timer tick, asking Buildbucket for the build status
[19:05:52.279] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:52.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:84:0) after 1m0s
[19:06:52.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:84:0)
[19:06:52.491] Timer tick, asking Buildbucket for the build status
[19:06:52.747] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:85:0) after 1m0s
[19:07:53.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:85:0)
[19:07:53.115] Timer tick, asking Buildbucket for the build status
[19:07:53.330] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:53.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:86:0) after 1m0s
[19:08:53.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:86:0)
[19:08:53.602] Timer tick, asking Buildbucket for the build status
[19:08:53.762] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:53.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:87:0) after 1m0s
[19:09:53.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:87:0)
[19:09:53.825] Timer tick, asking Buildbucket for the build status
[19:09:54.110] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:54.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:88:0) after 1m0s
[19:10:54.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:88:0)
[19:10:54.177] Timer tick, asking Buildbucket for the build status
[19:10:54.944] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:54.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:89:0) after 1m0s
[19:11:55.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:89:0)
[19:11:55.101] Timer tick, asking Buildbucket for the build status
[19:11:55.692] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:55.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:90:0) after 1m0s
[19:12:55.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:90:0)
[19:12:55.738] Timer tick, asking Buildbucket for the build status
[19:12:55.906] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:55.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:91:0) after 1m0s
[19:13:56.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:91:0)
[19:13:56.173] Timer tick, asking Buildbucket for the build status
[19:13:56.502] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:56.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:92:0) after 1m0s
[19:14:56.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:92:0)
[19:14:56.714] Timer tick, asking Buildbucket for the build status
[19:14:57.520] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:57.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:93:0) after 1m0s
[19:15:57.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:93:0)
[19:15:57.573] Timer tick, asking Buildbucket for the build status
[19:15:57.859] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:57.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:94:0) after 1m0s
[19:16:57.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:94:0)
[19:16:57.977] Timer tick, asking Buildbucket for the build status
[19:16:58.265] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:58.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:95:0) after 1m0s
[19:17:58.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:95:0)
[19:17:58.276] Timer tick, asking Buildbucket for the build status
[19:17:58.389] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:58.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:96:0) after 1m0s
[19:18:58.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:96:0)
[19:18:58.474] Timer tick, asking Buildbucket for the build status
[19:18:59.155] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:59.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:97:0) after 1m0s
[19:19:59.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:97:0)
[19:19:59.223] Timer tick, asking Buildbucket for the build status
[19:19:59.374] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:59.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:98:0) after 1m0s
[19:20:59.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:98:0)
[19:20:59.419] Timer tick, asking Buildbucket for the build status
[19:20:59.776] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:99:0) after 1m0s
[19:21:59.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:99:0)
[19:21:59.898] Timer tick, asking Buildbucket for the build status
[19:22:00.349] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:100:0) after 1m0s
[19:23:00.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:100:0)
[19:23:00.487] Timer tick, asking Buildbucket for the build status
[19:23:01.381] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:01.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:101:0) after 1m0s
[19:24:01.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:101:0)
[19:24:01.420] Timer tick, asking Buildbucket for the build status
[19:24:01.934] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:01.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:102:0) after 1m0s
[19:25:02.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:102:0)
[19:25:02.031] Timer tick, asking Buildbucket for the build status
[19:25:02.418] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:02.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:103:0) after 1m0s
[19:26:02.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:103:0)
[19:26:02.450] Timer tick, asking Buildbucket for the build status
[19:26:02.987] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:02.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:104:0) after 1m0s
[19:27:03.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:104:0)
[19:27:03.122] Timer tick, asking Buildbucket for the build status
[19:27:03.324] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:03.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:105:0) after 1m0s
[19:28:03.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:105:0)
[19:28:03.355] Timer tick, asking Buildbucket for the build status
[19:28:03.543] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:03.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:106:0) after 1m0s
[19:29:03.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:106:0)
[19:29:03.606] Timer tick, asking Buildbucket for the build status
[19:29:04.225] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:04.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:107:0) after 1m0s
[19:30:04.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:107:0)
[19:30:04.277] Timer tick, asking Buildbucket for the build status
[19:30:04.777] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:04.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:108:0) after 1m0s
[19:31:04.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:108:0)
[19:31:04.866] Timer tick, asking Buildbucket for the build status
[19:31:05.122] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:05.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:109:0) after 1m0s
[19:32:05.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:109:0)
[19:32:05.199] Timer tick, asking Buildbucket for the build status
[19:32:06.247] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:06.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:110:0) after 1m0s
[19:33:06.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:110:0)
[19:33:06.398] Timer tick, asking Buildbucket for the build status
[19:33:06.899] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:06.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:111:0) after 1m0s
[19:34:07.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:111:0)
[19:34:07.035] Timer tick, asking Buildbucket for the build status
[19:34:07.325] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:07.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:112:0) after 1m0s
[19:35:07.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:112:0)
[19:35:07.455] Timer tick, asking Buildbucket for the build status
[19:35:07.605] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:07.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:113:0) after 1m0s
[19:36:07.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:113:0)
[19:36:07.719] Timer tick, asking Buildbucket for the build status
[19:36:08.276] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:08.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:114:0) after 1m0s
[19:37:08.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:114:0)
[19:37:08.346] Timer tick, asking Buildbucket for the build status
[19:37:09.213] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:09.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:115:0) after 1m0s
[19:38:09.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:115:0)
[19:38:09.440] Timer tick, asking Buildbucket for the build status
[19:38:10.731] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:10.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:116:0) after 1m0s
[19:39:10.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:116:0)
[19:39:10.779] Timer tick, asking Buildbucket for the build status
[19:39:12.636] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:12.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:117:0) after 1m0s
[19:40:12.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:117:0)
[19:40:12.816] Timer tick, asking Buildbucket for the build status
[19:40:13.063] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:13.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:118:0) after 1m0s
[19:41:13.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:118:0)
[19:41:13.209] Timer tick, asking Buildbucket for the build status
[19:41:13.390] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:13.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:119:0) after 1m0s
[19:42:13.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:119:0)
[19:42:13.671] Timer tick, asking Buildbucket for the build status
[19:42:14.559] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:14.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:120:0) after 1m0s
[19:43:14.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:120:0)
[19:43:14.852] Timer tick, asking Buildbucket for the build status
[19:43:15.244] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:15.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:121:0) after 1m0s
[19:44:15.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:121:0)
[19:44:15.369] Timer tick, asking Buildbucket for the build status
[19:44:15.508] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:15.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:122:0) after 1m0s
[19:45:15.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:122:0)
[19:45:15.689] Timer tick, asking Buildbucket for the build status
[19:45:16.332] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:16.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:123:0) after 1m0s
[19:46:16.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:123:0)
[19:46:16.378] Timer tick, asking Buildbucket for the build status
[19:46:16.635] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:16.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:124:0) after 1m0s
[19:47:16.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:124:0)
[19:47:16.812] Timer tick, asking Buildbucket for the build status
[19:47:17.752] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:17.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:125:0) after 1m0s
[19:48:17.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:125:0)
[19:48:17.902] Timer tick, asking Buildbucket for the build status
[19:48:19.353] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:19.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:126:0) after 1m0s
[19:49:19.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:126:0)
[19:49:19.658] Timer tick, asking Buildbucket for the build status
[19:49:20.449] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:20.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:127:0) after 1m0s
[19:50:20.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:127:0)
[19:50:20.785] Timer tick, asking Buildbucket for the build status
[19:50:23.609] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:23.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:128:0) after 1m0s
[19:51:24.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:128:0)
[19:51:24.031] Timer tick, asking Buildbucket for the build status
[19:51:24.779] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:24.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:129:0) after 1m0s
[19:52:24.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:129:0)
[19:52:24.789] Timer tick, asking Buildbucket for the build status
[19:52:24.982] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:130:0) after 1m0s
[19:53:25.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:130:0)
[19:53:25.139] Timer tick, asking Buildbucket for the build status
[19:53:26.343] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:26.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:131:0) after 1m0s
[19:54:26.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:131:0)
[19:54:26.544] Timer tick, asking Buildbucket for the build status
[19:54:27.285] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:27.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:132:0) after 1m0s
[19:55:27.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:132:0)
[19:55:27.473] Timer tick, asking Buildbucket for the build status
[19:55:28.312] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:28.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:133:0) after 1m0s
[19:56:28.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:133:0)
[19:56:28.406] Timer tick, asking Buildbucket for the build status
[19:56:28.545] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:28.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:134:0) after 1m0s
[19:57:28.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:134:0)
[19:57:28.634] Timer tick, asking Buildbucket for the build status
[19:57:28.847] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:28.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:135:0) after 1m0s
[19:58:28.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:135:0)
[19:58:28.927] Timer tick, asking Buildbucket for the build status
[19:58:30.400] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:30.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:136:0) after 1m0s
[19:59:30.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:136:0)
[19:59:30.565] Timer tick, asking Buildbucket for the build status
[19:59:31.221] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:31.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:137:0) after 1m0s
[20:00:31.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:137:0)
[20:00:31.284] Timer tick, asking Buildbucket for the build status
[20:00:31.459] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:31.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:138:0) after 1m0s
[20:01:31.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:138:0)
[20:01:31.595] Timer tick, asking Buildbucket for the build status
[20:01:32.735] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:139:0) after 1m0s
[20:02:32.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:139:0)
[20:02:32.795] Timer tick, asking Buildbucket for the build status
[20:02:33.007] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:33.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:140:0) after 1m0s
[20:03:33.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:140:0)
[20:03:33.067] Timer tick, asking Buildbucket for the build status
[20:03:34.639] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:34.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:141:0) after 1m0s
[20:04:34.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:141:0)
[20:04:34.702] Timer tick, asking Buildbucket for the build status
[20:04:35.222] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:142:0) after 1m0s
[20:05:35.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:142:0)
[20:05:35.302] Timer tick, asking Buildbucket for the build status
[20:05:35.524] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:35.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:143:0) after 1m0s
[20:06:35.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:143:0)
[20:06:35.710] Timer tick, asking Buildbucket for the build status
[20:06:36.004] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:36.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:144:0) after 1m0s
[20:07:36.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:144:0)
[20:07:36.344] Timer tick, asking Buildbucket for the build status
[20:07:36.917] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:36.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:145:0) after 1m0s
[20:08:36.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:145:0)
[20:08:36.978] Timer tick, asking Buildbucket for the build status
[20:08:37.225] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:37.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:146:0) after 1m0s
[20:09:37.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:146:0)
[20:09:37.319] Timer tick, asking Buildbucket for the build status
[20:09:38.608] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:38.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:147:0) after 1m0s
[20:10:38.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:147:0)
[20:10:38.638] Timer tick, asking Buildbucket for the build status
[20:10:38.818] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:38.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:148:0) after 1m0s
[20:11:38.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:148:0)
[20:11:38.898] Timer tick, asking Buildbucket for the build status
[20:11:39.491] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:39.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:149:0) after 1m0s
[20:12:39.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:149:0)
[20:12:39.563] Timer tick, asking Buildbucket for the build status
[20:12:39.829] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:39.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:150:0) after 1m0s
[20:13:39.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:150:0)
[20:13:39.865] Timer tick, asking Buildbucket for the build status
[20:13:40.039] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:40.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:151:0) after 1m0s
[20:14:40.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:151:0)
[20:14:40.103] Timer tick, asking Buildbucket for the build status
[20:14:41.294] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:41.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:152:0) after 1m0s
[20:15:41.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:152:0)
[20:15:41.332] Timer tick, asking Buildbucket for the build status
[20:15:42.871] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:42.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:153:0) after 1m0s
[20:16:42.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:153:0)
[20:16:42.944] Timer tick, asking Buildbucket for the build status
[20:16:43.178] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:43.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:154:0) after 1m0s
[20:17:43.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:154:0)
[20:17:43.386] Timer tick, asking Buildbucket for the build status
[20:17:44.064] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:44.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:155:0) after 1m0s
[20:18:44.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:155:0)
[20:18:44.139] Timer tick, asking Buildbucket for the build status
[20:18:44.327] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:44.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:156:0) after 1m0s
[20:19:44.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:156:0)
[20:19:44.537] Timer tick, asking Buildbucket for the build status
[20:19:44.818] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:44.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:157:0) after 1m0s
[20:20:44.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:157:0)
[20:20:44.864] Timer tick, asking Buildbucket for the build status
[20:20:45.052] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:45.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:158:0) after 1m0s
[20:21:45.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:158:0)
[20:21:45.102] Timer tick, asking Buildbucket for the build status
[20:21:45.293] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:45.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:159:0) after 1m0s
[20:22:45.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:159:0)
[20:22:45.637] Timer tick, asking Buildbucket for the build status
[20:22:45.902] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:45.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:160:0) after 1m0s
[20:23:46.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:160:0)
[20:23:46.066] Timer tick, asking Buildbucket for the build status
[20:23:46.585] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:46.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:161:0) after 1m0s
[20:24:46.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:161:0)
[20:24:46.682] Timer tick, asking Buildbucket for the build status
[20:24:47.102] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:47.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:162:0) after 1m0s
[20:25:47.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:162:0)
[20:25:47.246] Timer tick, asking Buildbucket for the build status
[20:25:47.589] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:47.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:163:0) after 1m0s
[20:26:47.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:163:0)
[20:26:47.621] Timer tick, asking Buildbucket for the build status
[20:26:47.867] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:47.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:164:0) after 1m0s
[20:27:48.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:164:0)
[20:27:48.002] Timer tick, asking Buildbucket for the build status
[20:27:48.211] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:48.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:165:0) after 1m0s
[20:28:48.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:165:0)
[20:28:48.332] Timer tick, asking Buildbucket for the build status
[20:28:48.779] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:48.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:166:0) after 1m0s
[20:29:48.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:166:0)
[20:29:48.930] Timer tick, asking Buildbucket for the build status
[20:29:49.986] Build 8896340647866691248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:49.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061770710190989472:167:0) after 1m0s
[20:30:48.301] Received PubSub notification, asking Buildbucket for the build status
[20:30:48.504] Build 8896340647866691248: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:30:48.504] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574195446695035",
"created_by": "project:chromium",
"created_ts": "1574185436336822",
"failure_reason": "BUILD_FAILURE",
"id": "8896340647866691248",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43a60f8d83ed3c71709e0256083d90bac95bea65\"}}",
"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-t6xr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15244, \"got_angle_revision\": \"d22b8be4b457951ac255991d300845199753e063\", \"got_dawn_revision\": \"083a1ce2bf65e98103dfe500425fe0ca8aacb8f7\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"43a60f8d83ed3c71709e0256083d90bac95bea65\", \"got_revision_cp\": \"refs/heads/master@{#716687}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"79afb7620a69d0983de8b109837271f7beabe021\", \"got_v8_revision\": \"6ee4df806768fe08287750b9d87e5dec3f1d52a3\", \"got_v8_revision_cp\": \"refs/heads/8.0.303@{#1}\", \"got_webrtc_revision\": \"063c7d18c048a5869c286f0bce48f8debabab6b3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29832}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43a60f8d83ed3c71709e0256083d90bac95bea65\"}, \"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-t6xr\"], \"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\": [\"4638-f6b223c\"], \"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": "1574186146160069",
"status": "COMPLETED",
"status_changed_ts": "1574186146857011",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15244",
"builder:Windows deterministic",
"buildset:commit/git/43a60f8d83ed3c71709e0256083d90bac95bea65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43a60f8d83ed3c71709e0256083d90bac95bea65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061770710190989472",
"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/8896340647866691248/+/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:489d9525097ab710",
"user_agent:luci-scheduler"
],
"updated_ts": "1574195447000198",
"url": "https://ci.chromium.org/b/8896340647866691248",
"utcnow_ts": "1574195448479962"
}
}
[20:30:48.504] Invocation finished in 2h46m53.768025186s with status FAILED