[03:59:58.395] New invocation is queued and will start shortly
[03:59:59.526] Starting the invocation (attempt 1)
[03:59:59.575] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:59:59.579] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:59:59.579] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9063362696455214096",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f87c2b10efb4da6626fbb0042f94ce6da9c575bb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9063362696455214096",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"gitiles_ref:refs/heads/master"
]
}
[04:00:00.438] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1572667199762164",
"id": "8897932634300545760",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f87c2b10efb4da6626fbb0042f94ce6da9c575bb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572667200271325",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15096",
"builder:Windows deterministic",
"buildset:commit/git/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063362696455214096",
"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/8897932634300545760/+/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": "1572667200271433",
"url": "https://ci.chromium.org/b/8897932634300545760",
"utcnow_ts": "1572667200426711"
}
}
[04:00:00.438] Task URL: https://ci.chromium.org/b/8897932634300545760
[04:00:00.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:2:0) after 1m0s
[04:01:00.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:2:0)
[04:01:00.539] Timer tick, asking Buildbucket for the build status
[04:01:00.779] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:00.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:3:0) after 1m0s
[04:02:00.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:3:0)
[04:02:00.806] Timer tick, asking Buildbucket for the build status
[04:02:02.404] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:02.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:4:0) after 1m0s
[04:03:02.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:4:0)
[04:03:02.429] Timer tick, asking Buildbucket for the build status
[04:03:02.912] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:02.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:5:0) after 1m0s
[04:04:02.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:5:0)
[04:04:02.941] Timer tick, asking Buildbucket for the build status
[04:04:03.146] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:03.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:6:0) after 1m0s
[04:05:03.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:6:0)
[04:05:03.318] Timer tick, asking Buildbucket for the build status
[04:05:03.518] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:03.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:7:0) after 1m0s
[04:06:03.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:7:0)
[04:06:03.546] Timer tick, asking Buildbucket for the build status
[04:06:03.874] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:03.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:8:0) after 1m0s
[04:07:03.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:8:0)
[04:07:03.922] Timer tick, asking Buildbucket for the build status
[04:07:04.783] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:04.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:9:0) after 1m0s
[04:08:04.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:9:0)
[04:08:04.806] Timer tick, asking Buildbucket for the build status
[04:08:05.136] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:05.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:10:0) after 1m0s
[04:09:05.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:10:0)
[04:09:05.135] Timer tick, asking Buildbucket for the build status
[04:09:05.664] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:05.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:11:0) after 1m0s
[04:10:05.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:11:0)
[04:10:05.718] Timer tick, asking Buildbucket for the build status
[04:10:05.874] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:05.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:12:0) after 1m0s
[04:11:05.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:12:0)
[04:11:05.906] Timer tick, asking Buildbucket for the build status
[04:11:06.115] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:13:0) after 1m0s
[04:12:06.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:13:0)
[04:12:06.158] Timer tick, asking Buildbucket for the build status
[04:12:06.624] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:06.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:14:0) after 1m0s
[04:13:06.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:14:0)
[04:13:06.619] Timer tick, asking Buildbucket for the build status
[04:13:06.877] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:06.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:15:0) after 1m0s
[04:14:06.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:15:0)
[04:14:06.909] Timer tick, asking Buildbucket for the build status
[04:14:07.087] Build 8897932634300545760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:07.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:16:0) after 1m0s
[04:14:45.797] Received PubSub notification, asking Buildbucket for the build status
[04:14:46.175] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:07.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:16:0)
[04:15:07.078] Timer tick, asking Buildbucket for the build status
[04:15:07.210] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:07.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:18:0) after 1m0s
[04:16:07.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:18:0)
[04:16:07.236] Timer tick, asking Buildbucket for the build status
[04:16:07.435] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:07.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:19:0) after 1m0s
[04:17:07.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:19:0)
[04:17:07.458] Timer tick, asking Buildbucket for the build status
[04:17:07.863] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:07.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:20:0) after 1m0s
[04:18:07.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:20:0)
[04:18:07.910] Timer tick, asking Buildbucket for the build status
[04:18:08.423] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:08.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:21:0) after 1m0s
[04:19:08.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:21:0)
[04:19:08.513] Timer tick, asking Buildbucket for the build status
[04:19:09.033] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:09.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:22:0) after 1m0s
[04:20:09.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:22:0)
[04:20:09.059] Timer tick, asking Buildbucket for the build status
[04:20:09.329] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:23:0) after 1m0s
[04:21:09.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:23:0)
[04:21:09.356] Timer tick, asking Buildbucket for the build status
[04:21:10.716] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:10.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:24:0) after 1m0s
[04:22:10.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:24:0)
[04:22:10.742] Timer tick, asking Buildbucket for the build status
[04:22:11.098] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:11.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:25:0) after 1m0s
[04:23:11.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:25:0)
[04:23:11.202] Timer tick, asking Buildbucket for the build status
[04:23:11.572] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:11.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:26:0) after 1m0s
[04:24:11.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:26:0)
[04:24:11.641] Timer tick, asking Buildbucket for the build status
[04:24:12.432] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:27:0) after 1m0s
[04:25:12.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:27:0)
[04:25:12.465] Timer tick, asking Buildbucket for the build status
[04:25:12.842] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:12.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:28:0) after 1m0s
[04:26:12.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:28:0)
[04:26:12.833] Timer tick, asking Buildbucket for the build status
[04:26:13.460] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:29:0) after 1m0s
[04:27:13.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:29:0)
[04:27:13.449] Timer tick, asking Buildbucket for the build status
[04:27:14.000] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:30:0) after 1m0s
[04:28:14.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:30:0)
[04:28:14.028] Timer tick, asking Buildbucket for the build status
[04:28:14.636] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:14.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:31:0) after 1m0s
[04:29:14.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:31:0)
[04:29:14.665] Timer tick, asking Buildbucket for the build status
[04:29:14.909] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:14.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:32:0) after 1m0s
[04:30:15.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:32:0)
[04:30:15.034] Timer tick, asking Buildbucket for the build status
[04:30:15.205] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:15.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:33:0) after 1m0s
[04:31:15.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:33:0)
[04:31:15.232] Timer tick, asking Buildbucket for the build status
[04:31:16.691] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:16.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:34:0) after 1m0s
[04:32:16.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:34:0)
[04:32:16.824] Timer tick, asking Buildbucket for the build status
[04:32:17.054] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:17.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:35:0) after 1m0s
[04:33:17.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:35:0)
[04:33:17.163] Timer tick, asking Buildbucket for the build status
[04:33:17.461] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:17.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:36:0) after 1m0s
[04:34:17.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:36:0)
[04:34:17.531] Timer tick, asking Buildbucket for the build status
[04:34:18.119] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:18.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:37:0) after 1m0s
[04:35:18.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:37:0)
[04:35:18.278] Timer tick, asking Buildbucket for the build status
[04:35:22.255] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:22.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:38:0) after 1m0s
[04:36:22.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:38:0)
[04:36:22.336] Timer tick, asking Buildbucket for the build status
[04:36:22.597] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:22.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:39:0) after 1m0s
[04:37:22.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:39:0)
[04:37:22.594] Timer tick, asking Buildbucket for the build status
[04:37:22.786] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:22.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:40:0) after 1m0s
[04:38:22.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:40:0)
[04:38:22.906] Timer tick, asking Buildbucket for the build status
[04:38:23.111] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:23.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:41:0) after 1m0s
[04:39:23.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:41:0)
[04:39:23.198] Timer tick, asking Buildbucket for the build status
[04:39:23.352] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:23.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:42:0) after 1m0s
[04:40:23.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:42:0)
[04:40:23.382] Timer tick, asking Buildbucket for the build status
[04:40:26.053] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:26.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:43:0) after 1m0s
[04:41:26.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:43:0)
[04:41:26.746] Timer tick, asking Buildbucket for the build status
[04:41:27.070] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:27.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:44:0) after 1m0s
[04:42:27.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:44:0)
[04:42:27.417] Timer tick, asking Buildbucket for the build status
[04:42:27.621] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:27.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:45:0) after 1m0s
[04:43:27.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:45:0)
[04:43:27.695] Timer tick, asking Buildbucket for the build status
[04:43:28.308] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:28.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:46:0) after 1m0s
[04:44:28.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:46:0)
[04:44:28.664] Timer tick, asking Buildbucket for the build status
[04:44:29.228] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:47:0) after 1m0s
[04:45:29.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:47:0)
[04:45:29.532] Timer tick, asking Buildbucket for the build status
[04:45:29.741] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:29.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:48:0) after 1m0s
[04:46:30.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:48:0)
[04:46:30.030] Timer tick, asking Buildbucket for the build status
[04:46:30.379] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:30.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:49:0) after 1m0s
[04:47:30.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:49:0)
[04:47:30.736] Timer tick, asking Buildbucket for the build status
[04:47:31.321] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:31.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:50:0) after 1m0s
[04:48:31.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:50:0)
[04:48:31.433] Timer tick, asking Buildbucket for the build status
[04:48:31.893] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:31.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:51:0) after 1m0s
[04:49:32.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:51:0)
[04:49:32.074] Timer tick, asking Buildbucket for the build status
[04:49:32.360] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:32.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:52:0) after 1m0s
[04:50:32.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:52:0)
[04:50:32.589] Timer tick, asking Buildbucket for the build status
[04:50:33.597] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:33.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:53:0) after 1m0s
[04:51:33.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:53:0)
[04:51:33.757] Timer tick, asking Buildbucket for the build status
[04:51:35.571] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:35.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:54:0) after 1m0s
[04:52:35.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:54:0)
[04:52:35.637] Timer tick, asking Buildbucket for the build status
[04:52:35.861] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:35.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:55:0) after 1m0s
[04:53:35.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:55:0)
[04:53:35.924] Timer tick, asking Buildbucket for the build status
[04:53:36.189] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:36.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:56:0) after 1m0s
[04:54:36.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:56:0)
[04:54:36.329] Timer tick, asking Buildbucket for the build status
[04:54:38.772] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:57:0) after 1m0s
[04:55:38.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:57:0)
[04:55:38.799] Timer tick, asking Buildbucket for the build status
[04:55:38.991] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:58:0) after 1m0s
[04:56:39.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:58:0)
[04:56:39.024] Timer tick, asking Buildbucket for the build status
[04:56:39.559] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:39.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:59:0) after 1m0s
[04:57:39.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:59:0)
[04:57:39.637] Timer tick, asking Buildbucket for the build status
[04:57:39.866] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:60:0) after 1m0s
[04:58:39.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:60:0)
[04:58:39.963] Timer tick, asking Buildbucket for the build status
[04:58:42.303] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:42.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:61:0) after 1m0s
[04:59:42.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:61:0)
[04:59:42.316] Timer tick, asking Buildbucket for the build status
[04:59:42.543] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:42.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:62:0) after 1m0s
[05:00:42.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:62:0)
[05:00:42.622] Timer tick, asking Buildbucket for the build status
[05:00:43.615] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:43.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:63:0) after 1m0s
[05:01:43.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:63:0)
[05:01:43.648] Timer tick, asking Buildbucket for the build status
[05:01:44.206] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:44.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:64:0) after 1m0s
[05:02:44.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:64:0)
[05:02:44.256] Timer tick, asking Buildbucket for the build status
[05:02:44.573] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:44.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:65:0) after 1m0s
[05:03:44.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:65:0)
[05:03:44.619] Timer tick, asking Buildbucket for the build status
[05:03:44.834] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:44.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:66:0) after 1m0s
[05:04:44.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:66:0)
[05:04:44.888] Timer tick, asking Buildbucket for the build status
[05:04:45.174] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:45.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:67:0) after 1m0s
[05:05:45.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:67:0)
[05:05:45.275] Timer tick, asking Buildbucket for the build status
[05:05:45.751] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:45.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:68:0) after 1m0s
[05:06:45.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:68:0)
[05:06:45.869] Timer tick, asking Buildbucket for the build status
[05:06:46.177] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:46.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:69:0) after 1m0s
[05:07:46.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:69:0)
[05:07:46.408] Timer tick, asking Buildbucket for the build status
[05:07:46.841] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:46.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:70:0) after 1m0s
[05:08:46.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:70:0)
[05:08:46.926] Timer tick, asking Buildbucket for the build status
[05:08:47.513] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:47.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:71:0) after 1m0s
[05:09:47.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:71:0)
[05:09:47.545] Timer tick, asking Buildbucket for the build status
[05:09:48.807] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:48.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:72:0) after 1m0s
[05:10:49.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:72:0)
[05:10:49.069] Timer tick, asking Buildbucket for the build status
[05:10:49.490] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:49.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:73:0) after 1m0s
[05:11:49.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:73:0)
[05:11:49.704] Timer tick, asking Buildbucket for the build status
[05:11:50.064] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:50.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:74:0) after 1m0s
[05:12:50.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:74:0)
[05:12:50.095] Timer tick, asking Buildbucket for the build status
[05:12:51.194] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:51.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:75:0) after 1m0s
[05:13:51.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:75:0)
[05:13:51.292] Timer tick, asking Buildbucket for the build status
[05:13:51.465] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:51.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:76:0) after 1m0s
[05:14:51.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:76:0)
[05:14:51.645] Timer tick, asking Buildbucket for the build status
[05:14:53.378] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:53.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:77:0) after 1m0s
[05:15:53.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:77:0)
[05:15:53.806] Timer tick, asking Buildbucket for the build status
[05:15:53.969] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:53.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:78:0) after 1m0s
[05:16:54.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:78:0)
[05:16:54.230] Timer tick, asking Buildbucket for the build status
[05:16:54.652] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:54.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:79:0) after 1m0s
[05:17:54.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:79:0)
[05:17:54.935] Timer tick, asking Buildbucket for the build status
[05:17:55.165] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:80:0) after 1m0s
[05:18:55.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:80:0)
[05:18:55.200] Timer tick, asking Buildbucket for the build status
[05:18:55.521] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:81:0) after 1m0s
[05:19:55.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:81:0)
[05:19:55.558] Timer tick, asking Buildbucket for the build status
[05:19:55.890] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:55.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:82:0) after 1m0s
[05:20:56.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:82:0)
[05:20:56.037] Timer tick, asking Buildbucket for the build status
[05:20:56.585] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:56.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:83:0) after 1m0s
[05:21:56.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:83:0)
[05:21:56.789] Timer tick, asking Buildbucket for the build status
[05:21:56.966] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:56.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:84:0) after 1m0s
[05:22:57.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:84:0)
[05:22:57.276] Timer tick, asking Buildbucket for the build status
[05:22:57.705] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:57.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:85:0) after 1m0s
[05:23:58.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:85:0)
[05:23:58.155] Timer tick, asking Buildbucket for the build status
[05:23:58.366] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:58.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:86:0) after 1m0s
[05:24:58.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:86:0)
[05:24:58.902] Timer tick, asking Buildbucket for the build status
[05:25:01.201] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:01.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:87:0) after 1m0s
[05:26:01.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:87:0)
[05:26:01.648] Timer tick, asking Buildbucket for the build status
[05:26:01.896] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:01.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:88:0) after 1m0s
[05:27:02.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:88:0)
[05:27:02.072] Timer tick, asking Buildbucket for the build status
[05:27:02.346] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:02.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:89:0) after 1m0s
[05:28:02.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:89:0)
[05:28:02.504] Timer tick, asking Buildbucket for the build status
[05:28:02.674] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:02.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:90:0) after 1m0s
[05:29:02.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:90:0)
[05:29:02.695] Timer tick, asking Buildbucket for the build status
[05:29:02.925] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:02.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:91:0) after 1m0s
[05:30:02.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:91:0)
[05:30:02.958] Timer tick, asking Buildbucket for the build status
[05:30:03.722] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:03.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:92:0) after 1m0s
[05:31:03.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:92:0)
[05:31:03.768] Timer tick, asking Buildbucket for the build status
[05:31:04.038] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:04.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:93:0) after 1m0s
[05:32:04.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:93:0)
[05:32:04.184] Timer tick, asking Buildbucket for the build status
[05:32:04.415] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:04.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:94:0) after 1m0s
[05:33:04.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:94:0)
[05:33:04.566] Timer tick, asking Buildbucket for the build status
[05:33:04.760] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:04.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:95:0) after 1m0s
[05:34:04.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:95:0)
[05:34:04.994] Timer tick, asking Buildbucket for the build status
[05:34:05.356] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:05.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:96:0) after 1m0s
[05:35:05.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:96:0)
[05:35:05.496] Timer tick, asking Buildbucket for the build status
[05:35:06.035] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:97:0) after 1m0s
[05:36:06.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:97:0)
[05:36:06.211] Timer tick, asking Buildbucket for the build status
[05:36:06.901] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:06.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:98:0) after 1m0s
[05:37:07.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:98:0)
[05:37:07.038] Timer tick, asking Buildbucket for the build status
[05:37:07.486] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:07.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:99:0) after 1m0s
[05:38:07.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:99:0)
[05:38:07.513] Timer tick, asking Buildbucket for the build status
[05:38:07.731] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:07.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:100:0) after 1m0s
[05:39:07.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:100:0)
[05:39:07.768] Timer tick, asking Buildbucket for the build status
[05:39:07.961] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:07.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:101:0) after 1m0s
[05:40:08.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:101:0)
[05:40:08.062] Timer tick, asking Buildbucket for the build status
[05:40:08.809] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:08.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:102:0) after 1m0s
[05:41:08.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:102:0)
[05:41:08.886] Timer tick, asking Buildbucket for the build status
[05:41:09.145] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:09.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:103:0) after 1m0s
[05:42:09.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:103:0)
[05:42:09.279] Timer tick, asking Buildbucket for the build status
[05:42:10.514] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:10.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:104:0) after 1m0s
[05:43:10.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:104:0)
[05:43:10.537] Timer tick, asking Buildbucket for the build status
[05:43:11.369] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:11.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:105:0) after 1m0s
[05:44:11.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:105:0)
[05:44:11.353] Timer tick, asking Buildbucket for the build status
[05:44:11.583] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:11.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:106:0) after 1m0s
[05:45:11.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:106:0)
[05:45:11.615] Timer tick, asking Buildbucket for the build status
[05:45:12.853] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:12.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:107:0) after 1m0s
[05:46:12.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:107:0)
[05:46:12.883] Timer tick, asking Buildbucket for the build status
[05:46:13.037] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:13.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:108:0) after 1m0s
[05:47:13.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:108:0)
[05:47:13.111] Timer tick, asking Buildbucket for the build status
[05:47:13.323] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:13.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:109:0) after 1m0s
[05:48:13.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:109:0)
[05:48:13.350] Timer tick, asking Buildbucket for the build status
[05:48:13.669] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:13.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:110:0) after 1m0s
[05:49:13.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:110:0)
[05:49:13.807] Timer tick, asking Buildbucket for the build status
[05:49:14.009] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:14.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:111:0) after 1m0s
[05:50:14.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:111:0)
[05:50:14.051] Timer tick, asking Buildbucket for the build status
[05:50:14.535] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:14.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:112:0) after 1m0s
[05:51:14.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:112:0)
[05:51:14.594] Timer tick, asking Buildbucket for the build status
[05:51:15.741] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:15.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:113:0) after 1m0s
[05:52:15.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:113:0)
[05:52:15.767] Timer tick, asking Buildbucket for the build status
[05:52:16.014] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:16.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:114:0) after 1m0s
[05:53:16.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:114:0)
[05:53:16.041] Timer tick, asking Buildbucket for the build status
[05:53:16.714] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:16.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:115:0) after 1m0s
[05:54:16.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:115:0)
[05:54:16.770] Timer tick, asking Buildbucket for the build status
[05:54:17.089] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:17.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:116:0) after 1m0s
[05:55:17.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:116:0)
[05:55:17.124] Timer tick, asking Buildbucket for the build status
[05:55:17.261] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:17.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:117:0) after 1m0s
[05:56:17.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:117:0)
[05:56:17.285] Timer tick, asking Buildbucket for the build status
[05:56:17.948] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:17.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:118:0) after 1m0s
[05:57:18.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:118:0)
[05:57:18.099] Timer tick, asking Buildbucket for the build status
[05:57:18.291] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:18.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:119:0) after 1m0s
[05:58:18.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:119:0)
[05:58:18.324] Timer tick, asking Buildbucket for the build status
[05:58:18.990] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:120:0) after 1m0s
[05:59:19.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:120:0)
[05:59:19.028] Timer tick, asking Buildbucket for the build status
[05:59:19.502] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:19.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:121:0) after 1m0s
[06:00:19.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:121:0)
[06:00:19.571] Timer tick, asking Buildbucket for the build status
[06:00:19.725] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:19.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:122:0) after 1m0s
[06:01:19.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:122:0)
[06:01:19.809] Timer tick, asking Buildbucket for the build status
[06:01:20.048] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:20.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:123:0) after 1m0s
[06:02:20.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:123:0)
[06:02:20.101] Timer tick, asking Buildbucket for the build status
[06:02:20.311] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:20.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:124:0) after 1m0s
[06:03:20.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:124:0)
[06:03:20.384] Timer tick, asking Buildbucket for the build status
[06:03:21.163] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:21.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:125:0) after 1m0s
[06:04:21.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:125:0)
[06:04:21.257] Timer tick, asking Buildbucket for the build status
[06:04:21.810] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:21.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:126:0) after 1m0s
[06:05:21.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:126:0)
[06:05:21.867] Timer tick, asking Buildbucket for the build status
[06:05:22.923] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:22.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:127:0) after 1m0s
[06:06:23.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:127:0)
[06:06:23.037] Timer tick, asking Buildbucket for the build status
[06:06:23.430] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:23.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:128:0) after 1m0s
[06:07:23.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:128:0)
[06:07:23.455] Timer tick, asking Buildbucket for the build status
[06:07:23.698] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:23.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:129:0) after 1m0s
[06:08:23.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:129:0)
[06:08:23.726] Timer tick, asking Buildbucket for the build status
[06:08:23.974] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:23.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:130:0) after 1m0s
[06:09:24.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:130:0)
[06:09:24.005] Timer tick, asking Buildbucket for the build status
[06:09:26.914] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:26.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:131:0) after 1m0s
[06:10:26.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:131:0)
[06:10:26.961] Timer tick, asking Buildbucket for the build status
[06:10:30.388] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:30.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:132:0) after 1m0s
[06:11:30.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:132:0)
[06:11:30.427] Timer tick, asking Buildbucket for the build status
[06:11:30.852] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:30.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:133:0) after 1m0s
[06:12:30.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:133:0)
[06:12:30.889] Timer tick, asking Buildbucket for the build status
[06:12:31.734] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:31.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:134:0) after 1m0s
[06:13:31.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:134:0)
[06:13:31.795] Timer tick, asking Buildbucket for the build status
[06:13:32.058] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:32.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:135:0) after 1m0s
[06:14:32.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:135:0)
[06:14:32.097] Timer tick, asking Buildbucket for the build status
[06:14:32.500] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:32.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:136:0) after 1m0s
[06:15:32.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:136:0)
[06:15:32.508] Timer tick, asking Buildbucket for the build status
[06:15:33.611] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:33.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:137:0) after 1m0s
[06:16:33.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:137:0)
[06:16:33.683] Timer tick, asking Buildbucket for the build status
[06:16:33.904] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:33.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:138:0) after 1m0s
[06:17:34.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:138:0)
[06:17:34.098] Timer tick, asking Buildbucket for the build status
[06:17:34.296] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:34.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:139:0) after 1m0s
[06:18:34.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:139:0)
[06:18:34.323] Timer tick, asking Buildbucket for the build status
[06:18:34.893] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:34.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:140:0) after 1m0s
[06:19:34.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:140:0)
[06:19:34.934] Timer tick, asking Buildbucket for the build status
[06:19:35.138] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:35.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:141:0) after 1m0s
[06:20:35.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:141:0)
[06:20:35.179] Timer tick, asking Buildbucket for the build status
[06:20:36.578] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:36.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:142:0) after 1m0s
[06:21:36.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:142:0)
[06:21:36.748] Timer tick, asking Buildbucket for the build status
[06:21:37.478] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:37.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:143:0) after 1m0s
[06:22:37.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:143:0)
[06:22:37.579] Timer tick, asking Buildbucket for the build status
[06:22:37.823] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:37.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:144:0) after 1m0s
[06:23:37.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:144:0)
[06:23:37.859] Timer tick, asking Buildbucket for the build status
[06:23:40.571] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:40.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:145:0) after 1m0s
[06:24:40.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:145:0)
[06:24:40.612] Timer tick, asking Buildbucket for the build status
[06:24:41.273] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:41.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:146:0) after 1m0s
[06:25:41.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:146:0)
[06:25:41.300] Timer tick, asking Buildbucket for the build status
[06:25:41.945] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:41.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:147:0) after 1m0s
[06:26:42.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:147:0)
[06:26:42.002] Timer tick, asking Buildbucket for the build status
[06:26:42.572] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:42.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:148:0) after 1m0s
[06:27:42.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:148:0)
[06:27:42.609] Timer tick, asking Buildbucket for the build status
[06:27:42.793] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:42.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:149:0) after 1m0s
[06:28:42.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:149:0)
[06:28:42.879] Timer tick, asking Buildbucket for the build status
[06:28:43.418] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:150:0) after 1m0s
[06:29:43.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:150:0)
[06:29:43.450] Timer tick, asking Buildbucket for the build status
[06:29:44.237] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:151:0) after 1m0s
[06:30:44.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:151:0)
[06:30:44.392] Timer tick, asking Buildbucket for the build status
[06:30:45.512] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:45.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:152:0) after 1m0s
[06:31:45.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:152:0)
[06:31:45.714] Timer tick, asking Buildbucket for the build status
[06:31:45.999] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:45.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:153:0) after 1m0s
[06:32:46.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:153:0)
[06:32:46.038] Timer tick, asking Buildbucket for the build status
[06:32:46.277] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:46.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:154:0) after 1m0s
[06:33:46.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:154:0)
[06:33:46.352] Timer tick, asking Buildbucket for the build status
[06:33:47.236] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:47.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:155:0) after 1m0s
[06:34:47.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:155:0)
[06:34:47.271] Timer tick, asking Buildbucket for the build status
[06:34:47.472] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:47.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:156:0) after 1m0s
[06:35:47.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:156:0)
[06:35:47.633] Timer tick, asking Buildbucket for the build status
[06:35:48.227] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:48.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:157:0) after 1m0s
[06:36:48.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:157:0)
[06:36:48.268] Timer tick, asking Buildbucket for the build status
[06:36:49.135] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:49.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:158:0) after 1m0s
[06:37:49.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:158:0)
[06:37:49.214] Timer tick, asking Buildbucket for the build status
[06:37:49.588] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:49.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:159:0) after 1m0s
[06:38:49.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:159:0)
[06:38:49.632] Timer tick, asking Buildbucket for the build status
[06:38:50.940] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:50.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:160:0) after 1m0s
[06:39:50.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:160:0)
[06:39:50.974] Timer tick, asking Buildbucket for the build status
[06:39:52.122] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:52.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:161:0) after 1m0s
[06:40:52.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:161:0)
[06:40:52.206] Timer tick, asking Buildbucket for the build status
[06:40:52.598] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:52.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:162:0) after 1m0s
[06:41:52.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:162:0)
[06:41:52.687] Timer tick, asking Buildbucket for the build status
[06:41:54.835] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:54.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:163:0) after 1m0s
[06:42:55.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:163:0)
[06:42:55.159] Timer tick, asking Buildbucket for the build status
[06:42:55.882] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:55.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:164:0) after 1m0s
[06:43:56.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:164:0)
[06:43:56.056] Timer tick, asking Buildbucket for the build status
[06:43:58.756] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:165:0) after 1m0s
[06:44:58.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:165:0)
[06:44:58.794] Timer tick, asking Buildbucket for the build status
[06:44:59.034] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:59.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:166:0) after 1m0s
[06:45:59.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:166:0)
[06:45:59.108] Timer tick, asking Buildbucket for the build status
[06:45:59.693] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:59.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:167:0) after 1m0s
[06:46:59.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:167:0)
[06:46:59.721] Timer tick, asking Buildbucket for the build status
[06:46:59.987] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:59.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:168:0) after 1m0s
[06:48:00.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:168:0)
[06:48:00.018] Timer tick, asking Buildbucket for the build status
[06:48:01.621] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:01.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:169:0) after 1m0s
[06:49:01.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:169:0)
[06:49:01.743] Timer tick, asking Buildbucket for the build status
[06:49:02.155] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:02.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:170:0) after 1m0s
[06:50:02.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:170:0)
[06:50:02.215] Timer tick, asking Buildbucket for the build status
[06:50:02.479] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:02.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:171:0) after 1m0s
[06:51:02.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:171:0)
[06:51:02.694] Timer tick, asking Buildbucket for the build status
[06:51:03.044] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:03.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:172:0) after 1m0s
[06:52:03.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:172:0)
[06:52:03.103] Timer tick, asking Buildbucket for the build status
[06:52:03.817] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:03.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:173:0) after 1m0s
[06:53:03.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:173:0)
[06:53:03.848] Timer tick, asking Buildbucket for the build status
[06:53:04.405] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:04.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:174:0) after 1m0s
[06:54:04.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:174:0)
[06:54:04.459] Timer tick, asking Buildbucket for the build status
[06:54:04.807] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:04.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:175:0) after 1m0s
[06:55:04.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:175:0)
[06:55:04.864] Timer tick, asking Buildbucket for the build status
[06:55:05.175] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:05.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:176:0) after 1m0s
[06:56:05.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:176:0)
[06:56:05.246] Timer tick, asking Buildbucket for the build status
[06:56:06.127] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:06.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:177:0) after 1m0s
[06:57:06.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:177:0)
[06:57:06.163] Timer tick, asking Buildbucket for the build status
[06:57:06.651] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:06.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:178:0) after 1m0s
[06:58:06.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:178:0)
[06:58:06.755] Timer tick, asking Buildbucket for the build status
[06:58:07.425] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:07.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:179:0) after 1m0s
[06:59:07.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:179:0)
[06:59:07.489] Timer tick, asking Buildbucket for the build status
[06:59:07.663] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:07.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:180:0) after 1m0s
[07:00:07.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:180:0)
[07:00:07.783] Timer tick, asking Buildbucket for the build status
[07:00:07.955] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:07.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:181:0) after 1m0s
[07:01:07.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:181:0)
[07:01:07.991] Timer tick, asking Buildbucket for the build status
[07:01:08.581] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:08.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:182:0) after 1m0s
[07:02:08.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:182:0)
[07:02:08.605] Timer tick, asking Buildbucket for the build status
[07:02:08.844] Build 8897932634300545760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:08.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9063362696455214096:183:0) after 1m0s
[07:02:48.946] Received PubSub notification, asking Buildbucket for the build status
[07:02:49.492] Build 8897932634300545760: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:02:49.493] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1572678168075038",
"created_by": "project:chromium",
"created_ts": "1572667199762164",
"failure_reason": "BUILD_FAILURE",
"id": "8897932634300545760",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f87c2b10efb4da6626fbb0042f94ce6da9c575bb\"}}",
"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\": 15096, \"got_angle_revision\": \"422ebad20adb41017a351c9bb229c0ddcf13c918\", \"got_dawn_revision\": \"314fd3513d04fdc7412df0b6c7defc7b79356e8d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f87c2b10efb4da6626fbb0042f94ce6da9c575bb\", \"got_revision_cp\": \"refs/heads/master@{#711976}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"aaa64b76c0b40c2958a18cfdc623157c8c6e1b7d\", \"got_v8_revision\": \"b3cc49dff20c3be47be382add33fa521ea6fd561\", \"got_v8_revision_cp\": \"refs/heads/8.0.136@{#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\": \"f87c2b10efb4da6626fbb0042f94ce6da9c575bb\"}, \"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": "1572668084185476",
"status": "COMPLETED",
"status_changed_ts": "1572668085110621",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15096",
"builder:Windows deterministic",
"buildset:commit/git/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f87c2b10efb4da6626fbb0042f94ce6da9c575bb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063362696455214096",
"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/8897932634300545760/+/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:484316a5a78d8110",
"user_agent:luci-scheduler"
],
"updated_ts": "1572678168479750",
"url": "https://ci.chromium.org/b/8897932634300545760",
"utcnow_ts": "1572678169442405"
}
}
[07:02:49.493] Invocation finished in 3h2m51.168825397s with status FAILED