[06:05:52.143] New invocation is queued and will start shortly
[06:05:53.328] Starting the invocation (attempt 1)
[06:05:53.370] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:05:53.371] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:05:53.371] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067975221008773776",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e274f2396dae7d685e725c93745f2828739f0972\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9067975221008773776",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e274f2396dae7d685e725c93745f2828739f0972",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e274f2396dae7d685e725c93745f2828739f0972",
"gitiles_ref:refs/heads/master"
]
}
[06:05:54.794] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1568268353917435",
"id": "8902545158481132896",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e274f2396dae7d685e725c93745f2828739f0972\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568268354561226",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14697",
"builder:Windows deterministic",
"buildset:commit/git/e274f2396dae7d685e725c93745f2828739f0972",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e274f2396dae7d685e725c93745f2828739f0972",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067975221008773776",
"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/8902545158481132896/+/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": "1568268354561380",
"url": "https://ci.chromium.org/b/8902545158481132896",
"utcnow_ts": "1568268354782055"
}
}
[06:05:54.794] Task URL: https://ci.chromium.org/b/8902545158481132896
[06:05:54.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:2:0) after 1m0s
[06:06:54.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:2:0)
[06:06:54.817] Timer tick, asking Buildbucket for the build status
[06:06:55.026] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:55.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:3:0) after 1m0s
[06:07:55.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:3:0)
[06:07:55.111] Timer tick, asking Buildbucket for the build status
[06:07:55.967] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:55.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:4:0) after 1m0s
[06:08:55.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:4:0)
[06:08:55.980] Timer tick, asking Buildbucket for the build status
[06:08:56.137] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:56.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:5:0) after 1m0s
[06:09:56.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:5:0)
[06:09:56.161] Timer tick, asking Buildbucket for the build status
[06:09:56.469] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:56.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:6:0) after 1m0s
[06:10:56.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:6:0)
[06:10:56.501] Timer tick, asking Buildbucket for the build status
[06:10:56.683] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:56.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:7:0) after 1m0s
[06:11:56.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:7:0)
[06:11:56.748] Timer tick, asking Buildbucket for the build status
[06:12:00.325] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:00.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:8:0) after 1m0s
[06:13:00.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:8:0)
[06:13:00.346] Timer tick, asking Buildbucket for the build status
[06:13:02.709] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:02.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:9:0) after 1m0s
[06:14:02.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:9:0)
[06:14:02.811] Timer tick, asking Buildbucket for the build status
[06:14:03.744] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:03.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:10:0) after 1m0s
[06:15:04.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:10:0)
[06:15:04.189] Timer tick, asking Buildbucket for the build status
[06:15:04.889] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:04.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:11:0) after 1m0s
[06:16:04.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:11:0)
[06:16:04.971] Timer tick, asking Buildbucket for the build status
[06:16:05.859] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:05.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:12:0) after 1m0s
[06:17:06.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:12:0)
[06:17:06.177] Timer tick, asking Buildbucket for the build status
[06:17:06.681] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:06.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:13:0) after 1m0s
[06:18:06.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:13:0)
[06:18:06.881] Timer tick, asking Buildbucket for the build status
[06:18:07.049] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:07.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:14:0) after 1m0s
[06:19:07.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:14:0)
[06:19:07.619] Timer tick, asking Buildbucket for the build status
[06:19:10.448] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:10.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:15:0) after 1m0s
[06:20:10.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:15:0)
[06:20:10.509] Timer tick, asking Buildbucket for the build status
[06:20:11.550] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:11.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:16:0) after 1m0s
[06:21:11.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:16:0)
[06:21:11.596] Timer tick, asking Buildbucket for the build status
[06:21:12.094] Build 8902545158481132896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:12.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:17:0) after 1m0s
[06:21:17.196] Received PubSub notification, asking Buildbucket for the build status
[06:21:17.794] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:12.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:17:0)
[06:22:12.154] Timer tick, asking Buildbucket for the build status
[06:22:12.521] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:12.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:19:0) after 1m0s
[06:23:12.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:19:0)
[06:23:12.550] Timer tick, asking Buildbucket for the build status
[06:23:13.361] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:13.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:20:0) after 1m0s
[06:24:13.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:20:0)
[06:24:13.391] Timer tick, asking Buildbucket for the build status
[06:24:14.250] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:14.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:21:0) after 1m0s
[06:25:14.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:21:0)
[06:25:14.286] Timer tick, asking Buildbucket for the build status
[06:25:14.543] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:22:0) after 1m0s
[06:26:14.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:22:0)
[06:26:14.593] Timer tick, asking Buildbucket for the build status
[06:26:14.881] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:14.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:23:0) after 1m0s
[06:27:14.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:23:0)
[06:27:14.933] Timer tick, asking Buildbucket for the build status
[06:27:15.147] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:15.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:24:0) after 1m0s
[06:28:15.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:24:0)
[06:28:15.322] Timer tick, asking Buildbucket for the build status
[06:28:15.584] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:15.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:25:0) after 1m0s
[06:29:15.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:25:0)
[06:29:15.717] Timer tick, asking Buildbucket for the build status
[06:29:16.149] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:16.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:26:0) after 1m0s
[06:30:16.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:26:0)
[06:30:16.200] Timer tick, asking Buildbucket for the build status
[06:30:16.766] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:16.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:27:0) after 1m0s
[06:31:16.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:27:0)
[06:31:16.791] Timer tick, asking Buildbucket for the build status
[06:31:17.422] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:17.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:28:0) after 1m0s
[06:32:17.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:28:0)
[06:32:17.448] Timer tick, asking Buildbucket for the build status
[06:32:17.739] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:29:0) after 1m0s
[06:33:17.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:29:0)
[06:33:17.771] Timer tick, asking Buildbucket for the build status
[06:33:18.075] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:30:0) after 1m0s
[06:34:18.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:30:0)
[06:34:18.088] Timer tick, asking Buildbucket for the build status
[06:34:18.609] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:18.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:31:0) after 1m0s
[06:35:18.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:31:0)
[06:35:18.734] Timer tick, asking Buildbucket for the build status
[06:35:18.968] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:18.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:32:0) after 1m0s
[06:36:19.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:32:0)
[06:36:19.044] Timer tick, asking Buildbucket for the build status
[06:36:19.512] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:33:0) after 1m0s
[06:37:19.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:33:0)
[06:37:19.503] Timer tick, asking Buildbucket for the build status
[06:37:19.684] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:19.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:34:0) after 1m0s
[06:38:19.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:34:0)
[06:38:19.719] Timer tick, asking Buildbucket for the build status
[06:38:20.132] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:20.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:35:0) after 1m0s
[06:39:20.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:35:0)
[06:39:20.168] Timer tick, asking Buildbucket for the build status
[06:39:25.133] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:25.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:36:0) after 1m0s
[06:40:25.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:36:0)
[06:40:25.137] Timer tick, asking Buildbucket for the build status
[06:40:25.408] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:25.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:37:0) after 1m0s
[06:41:25.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:37:0)
[06:41:25.448] Timer tick, asking Buildbucket for the build status
[06:41:27.908] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:27.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:38:0) after 1m0s
[06:42:27.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:38:0)
[06:42:27.960] Timer tick, asking Buildbucket for the build status
[06:42:28.378] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:28.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:39:0) after 1m0s
[06:43:28.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:39:0)
[06:43:28.379] Timer tick, asking Buildbucket for the build status
[06:43:28.687] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:28.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:40:0) after 1m0s
[06:44:28.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:40:0)
[06:44:28.807] Timer tick, asking Buildbucket for the build status
[06:44:31.787] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:31.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:41:0) after 1m0s
[06:45:31.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:41:0)
[06:45:31.801] Timer tick, asking Buildbucket for the build status
[06:45:35.173] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:35.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:42:0) after 1m0s
[06:46:35.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:42:0)
[06:46:35.186] Timer tick, asking Buildbucket for the build status
[06:46:37.623] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:37.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:43:0) after 1m0s
[06:47:37.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:43:0)
[06:47:37.597] Timer tick, asking Buildbucket for the build status
[06:47:38.477] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:38.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:44:0) after 1m0s
[06:48:38.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:44:0)
[06:48:38.571] Timer tick, asking Buildbucket for the build status
[06:48:38.935] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:38.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:45:0) after 1m0s
[06:49:38.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:45:0)
[06:49:38.982] Timer tick, asking Buildbucket for the build status
[06:49:39.931] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:39.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:46:0) after 1m0s
[06:50:39.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:46:0)
[06:50:39.956] Timer tick, asking Buildbucket for the build status
[06:50:40.133] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:40.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:47:0) after 1m0s
[06:51:40.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:47:0)
[06:51:40.175] Timer tick, asking Buildbucket for the build status
[06:51:40.919] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:40.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:48:0) after 1m0s
[06:52:40.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:48:0)
[06:52:40.944] Timer tick, asking Buildbucket for the build status
[06:52:41.182] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:41.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:49:0) after 1m0s
[06:53:41.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:49:0)
[06:53:41.245] Timer tick, asking Buildbucket for the build status
[06:53:41.567] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:41.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:50:0) after 1m0s
[06:54:41.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:50:0)
[06:54:41.605] Timer tick, asking Buildbucket for the build status
[06:54:42.437] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:42.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:51:0) after 1m0s
[06:55:42.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:51:0)
[06:55:42.504] Timer tick, asking Buildbucket for the build status
[06:55:42.797] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:42.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:52:0) after 1m0s
[06:56:42.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:52:0)
[06:56:42.828] Timer tick, asking Buildbucket for the build status
[06:56:44.505] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:44.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:53:0) after 1m0s
[06:57:44.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:53:0)
[06:57:44.533] Timer tick, asking Buildbucket for the build status
[06:57:45.282] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:45.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:54:0) after 1m0s
[06:58:45.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:54:0)
[06:58:45.299] Timer tick, asking Buildbucket for the build status
[06:58:46.207] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:46.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:55:0) after 1m0s
[06:59:46.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:55:0)
[06:59:46.473] Timer tick, asking Buildbucket for the build status
[06:59:47.739] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:47.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:56:0) after 1m0s
[07:00:47.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:56:0)
[07:00:47.779] Timer tick, asking Buildbucket for the build status
[07:00:48.239] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:48.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:57:0) after 1m0s
[07:01:48.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:57:0)
[07:01:48.266] Timer tick, asking Buildbucket for the build status
[07:01:48.466] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:48.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:58:0) after 1m0s
[07:02:48.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:58:0)
[07:02:48.492] Timer tick, asking Buildbucket for the build status
[07:02:49.713] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:49.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:59:0) after 1m0s
[07:03:49.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:59:0)
[07:03:49.804] Timer tick, asking Buildbucket for the build status
[07:03:50.919] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:50.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:60:0) after 1m0s
[07:04:50.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:60:0)
[07:04:50.982] Timer tick, asking Buildbucket for the build status
[07:04:53.977] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:53.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:61:0) after 1m0s
[07:05:54.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:61:0)
[07:05:54.137] Timer tick, asking Buildbucket for the build status
[07:05:56.167] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:56.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:62:0) after 1m0s
[07:06:56.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:62:0)
[07:06:56.292] Timer tick, asking Buildbucket for the build status
[07:06:56.626] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:56.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:63:0) after 1m0s
[07:07:56.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:63:0)
[07:07:56.662] Timer tick, asking Buildbucket for the build status
[07:07:57.036] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:57.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:64:0) after 1m0s
[07:08:57.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:64:0)
[07:08:57.115] Timer tick, asking Buildbucket for the build status
[07:08:58.441] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:65:0) after 1m0s
[07:09:58.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:65:0)
[07:09:58.499] Timer tick, asking Buildbucket for the build status
[07:09:58.706] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:58.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:66:0) after 1m0s
[07:10:58.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:66:0)
[07:10:58.782] Timer tick, asking Buildbucket for the build status
[07:11:00.035] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:00.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:67:0) after 1m0s
[07:12:00.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:67:0)
[07:12:00.066] Timer tick, asking Buildbucket for the build status
[07:12:00.521] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:00.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:68:0) after 1m0s
[07:13:00.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:68:0)
[07:13:00.601] Timer tick, asking Buildbucket for the build status
[07:13:01.045] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:01.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:69:0) after 1m0s
[07:14:01.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:69:0)
[07:14:01.023] Timer tick, asking Buildbucket for the build status
[07:14:01.294] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:01.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:70:0) after 1m0s
[07:15:01.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:70:0)
[07:15:01.383] Timer tick, asking Buildbucket for the build status
[07:15:02.077] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:71:0) after 1m0s
[07:16:02.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:71:0)
[07:16:02.169] Timer tick, asking Buildbucket for the build status
[07:16:02.725] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:02.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:72:0) after 1m0s
[07:17:02.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:72:0)
[07:17:02.873] Timer tick, asking Buildbucket for the build status
[07:17:03.293] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:03.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:73:0) after 1m0s
[07:18:03.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:73:0)
[07:18:03.351] Timer tick, asking Buildbucket for the build status
[07:18:03.595] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:03.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:74:0) after 1m0s
[07:19:03.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:74:0)
[07:19:03.642] Timer tick, asking Buildbucket for the build status
[07:19:03.782] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:03.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:75:0) after 1m0s
[07:20:03.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:75:0)
[07:20:03.829] Timer tick, asking Buildbucket for the build status
[07:20:05.236] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:05.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:76:0) after 1m0s
[07:21:05.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:76:0)
[07:21:05.330] Timer tick, asking Buildbucket for the build status
[07:21:06.860] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:06.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:77:0) after 1m0s
[07:22:06.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:77:0)
[07:22:06.924] Timer tick, asking Buildbucket for the build status
[07:22:07.127] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:07.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:78:0) after 1m0s
[07:23:07.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:78:0)
[07:23:07.166] Timer tick, asking Buildbucket for the build status
[07:23:07.515] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:07.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:79:0) after 1m0s
[07:24:07.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:79:0)
[07:24:07.663] Timer tick, asking Buildbucket for the build status
[07:24:07.849] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:07.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:80:0) after 1m0s
[07:25:07.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:80:0)
[07:25:07.923] Timer tick, asking Buildbucket for the build status
[07:25:08.529] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:08.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:81:0) after 1m0s
[07:26:08.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:81:0)
[07:26:08.812] Timer tick, asking Buildbucket for the build status
[07:26:09.387] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:09.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:82:0) after 1m0s
[07:27:09.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:82:0)
[07:27:09.554] Timer tick, asking Buildbucket for the build status
[07:27:11.677] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:11.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:83:0) after 1m0s
[07:28:11.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:83:0)
[07:28:11.743] Timer tick, asking Buildbucket for the build status
[07:28:11.918] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:11.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:84:0) after 1m0s
[07:29:12.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:84:0)
[07:29:12.059] Timer tick, asking Buildbucket for the build status
[07:29:14.856] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:14.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:85:0) after 1m0s
[07:30:14.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:85:0)
[07:30:14.906] Timer tick, asking Buildbucket for the build status
[07:30:15.144] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:15.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:86:0) after 1m0s
[07:31:15.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:86:0)
[07:31:15.174] Timer tick, asking Buildbucket for the build status
[07:31:15.364] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:15.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:87:0) after 1m0s
[07:32:15.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:87:0)
[07:32:15.383] Timer tick, asking Buildbucket for the build status
[07:32:16.538] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:16.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:88:0) after 1m0s
[07:33:16.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:88:0)
[07:33:16.621] Timer tick, asking Buildbucket for the build status
[07:33:18.087] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:18.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:89:0) after 1m0s
[07:34:18.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:89:0)
[07:34:18.317] Timer tick, asking Buildbucket for the build status
[07:34:18.692] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:18.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:90:0) after 1m0s
[07:35:18.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:90:0)
[07:35:18.790] Timer tick, asking Buildbucket for the build status
[07:35:19.046] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:91:0) after 1m0s
[07:36:19.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:91:0)
[07:36:19.552] Timer tick, asking Buildbucket for the build status
[07:36:20.070] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:20.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:92:0) after 1m0s
[07:37:20.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:92:0)
[07:37:20.109] Timer tick, asking Buildbucket for the build status
[07:37:20.302] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:93:0) after 1m0s
[07:38:20.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:93:0)
[07:38:20.387] Timer tick, asking Buildbucket for the build status
[07:38:21.461] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:21.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:94:0) after 1m0s
[07:39:22.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:94:0)
[07:39:22.984] Timer tick, asking Buildbucket for the build status
[07:39:23.927] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:23.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:95:0) after 1m0s
[07:40:24.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:95:0)
[07:40:24.219] Timer tick, asking Buildbucket for the build status
[07:40:24.572] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:24.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:96:0) after 1m0s
[07:41:26.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:96:0)
[07:41:26.007] Timer tick, asking Buildbucket for the build status
[07:41:28.655] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:28.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:97:0) after 1m0s
[07:42:28.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:97:0)
[07:42:28.849] Timer tick, asking Buildbucket for the build status
[07:42:30.841] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:30.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:98:0) after 1m0s
[07:43:30.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:98:0)
[07:43:30.951] Timer tick, asking Buildbucket for the build status
[07:43:31.440] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:31.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:99:0) after 1m0s
[07:44:31.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:99:0)
[07:44:31.473] Timer tick, asking Buildbucket for the build status
[07:44:32.181] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:32.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:100:0) after 1m0s
[07:45:32.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:100:0)
[07:45:32.301] Timer tick, asking Buildbucket for the build status
[07:45:32.771] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:101:0) after 1m0s
[07:46:32.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:101:0)
[07:46:32.899] Timer tick, asking Buildbucket for the build status
[07:46:33.071] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:33.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:102:0) after 1m0s
[07:47:33.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:102:0)
[07:47:33.161] Timer tick, asking Buildbucket for the build status
[07:47:34.350] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:34.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:103:0) after 1m0s
[07:48:34.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:103:0)
[07:48:34.380] Timer tick, asking Buildbucket for the build status
[07:48:34.927] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:104:0) after 1m0s
[07:49:35.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:104:0)
[07:49:35.291] Timer tick, asking Buildbucket for the build status
[07:49:35.538] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:35.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:105:0) after 1m0s
[07:50:36.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:105:0)
[07:50:36.731] Timer tick, asking Buildbucket for the build status
[07:50:39.699] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:39.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:106:0) after 1m0s
[07:51:39.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:106:0)
[07:51:39.817] Timer tick, asking Buildbucket for the build status
[07:51:40.323] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:40.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:107:0) after 1m0s
[07:52:40.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:107:0)
[07:52:40.650] Timer tick, asking Buildbucket for the build status
[07:52:41.100] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:41.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:108:0) after 1m0s
[07:53:41.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:108:0)
[07:53:41.126] Timer tick, asking Buildbucket for the build status
[07:53:41.915] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:41.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:109:0) after 1m0s
[07:54:41.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:109:0)
[07:54:41.945] Timer tick, asking Buildbucket for the build status
[07:54:43.053] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:43.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:110:0) after 1m0s
[07:55:43.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:110:0)
[07:55:43.089] Timer tick, asking Buildbucket for the build status
[07:55:44.040] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:44.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:111:0) after 1m0s
[07:56:44.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:111:0)
[07:56:44.072] Timer tick, asking Buildbucket for the build status
[07:56:44.886] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:44.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:112:0) after 1m0s
[07:57:44.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:112:0)
[07:57:44.901] Timer tick, asking Buildbucket for the build status
[07:57:47.398] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:47.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:113:0) after 1m0s
[07:58:47.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:113:0)
[07:58:47.426] Timer tick, asking Buildbucket for the build status
[07:58:49.720] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:114:0) after 1m0s
[07:59:49.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:114:0)
[07:59:49.783] Timer tick, asking Buildbucket for the build status
[07:59:49.982] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:49.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:115:0) after 1m0s
[08:00:50.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:115:0)
[08:00:50.026] Timer tick, asking Buildbucket for the build status
[08:00:50.966] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:50.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:116:0) after 1m0s
[08:01:51.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:116:0)
[08:01:51.046] Timer tick, asking Buildbucket for the build status
[08:01:51.392] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:117:0) after 1m0s
[08:02:51.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:117:0)
[08:02:51.460] Timer tick, asking Buildbucket for the build status
[08:02:51.717] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:51.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:118:0) after 1m0s
[08:03:51.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:118:0)
[08:03:51.747] Timer tick, asking Buildbucket for the build status
[08:03:52.848] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:52.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:119:0) after 1m0s
[08:04:52.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:119:0)
[08:04:52.931] Timer tick, asking Buildbucket for the build status
[08:04:54.201] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:54.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:120:0) after 1m0s
[08:05:54.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:120:0)
[08:05:54.234] Timer tick, asking Buildbucket for the build status
[08:05:55.098] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:55.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:121:0) after 1m0s
[08:06:55.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:121:0)
[08:06:55.083] Timer tick, asking Buildbucket for the build status
[08:06:55.389] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:55.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:122:0) after 1m0s
[08:07:55.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:122:0)
[08:07:55.428] Timer tick, asking Buildbucket for the build status
[08:07:57.430] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:123:0) after 1m0s
[08:08:57.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:123:0)
[08:08:57.554] Timer tick, asking Buildbucket for the build status
[08:08:57.749] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:57.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:124:0) after 1m0s
[08:09:57.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:124:0)
[08:09:57.788] Timer tick, asking Buildbucket for the build status
[08:09:58.242] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:58.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:125:0) after 1m0s
[08:10:58.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:125:0)
[08:10:58.323] Timer tick, asking Buildbucket for the build status
[08:10:58.985] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:126:0) after 1m0s
[08:11:58.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:126:0)
[08:11:58.998] Timer tick, asking Buildbucket for the build status
[08:11:59.208] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:59.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:127:0) after 1m0s
[08:12:59.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:127:0)
[08:12:59.246] Timer tick, asking Buildbucket for the build status
[08:12:59.493] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:59.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:128:0) after 1m0s
[08:13:59.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:128:0)
[08:13:59.568] Timer tick, asking Buildbucket for the build status
[08:13:59.982] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:59.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:129:0) after 1m0s
[08:15:00.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:129:0)
[08:15:00.041] Timer tick, asking Buildbucket for the build status
[08:15:00.570] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:00.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:130:0) after 1m0s
[08:16:00.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:130:0)
[08:16:00.573] Timer tick, asking Buildbucket for the build status
[08:16:03.544] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:03.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:131:0) after 1m0s
[08:17:03.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:131:0)
[08:17:03.555] Timer tick, asking Buildbucket for the build status
[08:17:05.738] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:05.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:132:0) after 1m0s
[08:18:05.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:132:0)
[08:18:05.809] Timer tick, asking Buildbucket for the build status
[08:18:06.506] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:06.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:133:0) after 1m0s
[08:19:06.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:133:0)
[08:19:06.536] Timer tick, asking Buildbucket for the build status
[08:19:06.900] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:06.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:134:0) after 1m0s
[08:20:06.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:134:0)
[08:20:06.967] Timer tick, asking Buildbucket for the build status
[08:20:10.244] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:10.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:135:0) after 1m0s
[08:21:10.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:135:0)
[08:21:10.241] Timer tick, asking Buildbucket for the build status
[08:21:11.543] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:11.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:136:0) after 1m0s
[08:22:11.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:136:0)
[08:22:11.675] Timer tick, asking Buildbucket for the build status
[08:22:11.992] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:11.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:137:0) after 1m0s
[08:23:12.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:137:0)
[08:23:12.122] Timer tick, asking Buildbucket for the build status
[08:23:14.281] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:14.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:138:0) after 1m0s
[08:24:14.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:138:0)
[08:24:14.340] Timer tick, asking Buildbucket for the build status
[08:24:16.975] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:139:0) after 1m0s
[08:25:16.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:139:0)
[08:25:16.990] Timer tick, asking Buildbucket for the build status
[08:25:17.337] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:17.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:140:0) after 1m0s
[08:26:17.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:140:0)
[08:26:17.386] Timer tick, asking Buildbucket for the build status
[08:26:17.590] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:141:0) after 1m0s
[08:27:17.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:141:0)
[08:27:17.702] Timer tick, asking Buildbucket for the build status
[08:27:18.132] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:18.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:142:0) after 1m0s
[08:28:18.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:142:0)
[08:28:18.200] Timer tick, asking Buildbucket for the build status
[08:28:18.461] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:18.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:143:0) after 1m0s
[08:29:18.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:143:0)
[08:29:18.502] Timer tick, asking Buildbucket for the build status
[08:29:18.920] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:18.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:144:0) after 1m0s
[08:30:18.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:144:0)
[08:30:18.944] Timer tick, asking Buildbucket for the build status
[08:30:22.818] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:22.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:145:0) after 1m0s
[08:31:22.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:145:0)
[08:31:22.889] Timer tick, asking Buildbucket for the build status
[08:31:23.075] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:23.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:146:0) after 1m0s
[08:32:23.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:146:0)
[08:32:23.099] Timer tick, asking Buildbucket for the build status
[08:32:23.913] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:23.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:147:0) after 1m0s
[08:33:23.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:147:0)
[08:33:23.928] Timer tick, asking Buildbucket for the build status
[08:33:25.518] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:25.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:148:0) after 1m0s
[08:34:25.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:148:0)
[08:34:25.570] Timer tick, asking Buildbucket for the build status
[08:34:28.296] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:28.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:149:0) after 1m0s
[08:35:28.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:149:0)
[08:35:28.575] Timer tick, asking Buildbucket for the build status
[08:35:29.831] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:29.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:150:0) after 1m0s
[08:36:29.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:150:0)
[08:36:29.870] Timer tick, asking Buildbucket for the build status
[08:36:34.015] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:34.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:151:0) after 1m0s
[08:37:34.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:151:0)
[08:37:34.081] Timer tick, asking Buildbucket for the build status
[08:37:34.256] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:34.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:152:0) after 1m0s
[08:38:34.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:152:0)
[08:38:34.280] Timer tick, asking Buildbucket for the build status
[08:38:37.517] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:37.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:153:0) after 1m0s
[08:39:37.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:153:0)
[08:39:37.563] Timer tick, asking Buildbucket for the build status
[08:39:37.922] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:37.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:154:0) after 1m0s
[08:40:37.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:154:0)
[08:40:37.984] Timer tick, asking Buildbucket for the build status
[08:40:38.483] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:38.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:155:0) after 1m0s
[08:41:38.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:155:0)
[08:41:38.534] Timer tick, asking Buildbucket for the build status
[08:41:41.563] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:41.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:156:0) after 1m0s
[08:42:41.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:156:0)
[08:42:41.682] Timer tick, asking Buildbucket for the build status
[08:42:42.358] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:42.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:157:0) after 1m0s
[08:43:42.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:157:0)
[08:43:42.450] Timer tick, asking Buildbucket for the build status
[08:43:44.326] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:44.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:158:0) after 1m0s
[08:44:44.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:158:0)
[08:44:44.354] Timer tick, asking Buildbucket for the build status
[08:44:47.921] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:47.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:159:0) after 1m0s
[08:45:47.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:159:0)
[08:45:47.979] Timer tick, asking Buildbucket for the build status
[08:45:48.248] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:48.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:160:0) after 1m0s
[08:46:48.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:160:0)
[08:46:48.387] Timer tick, asking Buildbucket for the build status
[08:46:50.026] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:50.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:161:0) after 1m0s
[08:47:50.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:161:0)
[08:47:50.077] Timer tick, asking Buildbucket for the build status
[08:47:51.423] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:51.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:162:0) after 1m0s
[08:48:51.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:162:0)
[08:48:51.501] Timer tick, asking Buildbucket for the build status
[08:48:52.210] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:163:0) after 1m0s
[08:49:52.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:163:0)
[08:49:52.350] Timer tick, asking Buildbucket for the build status
[08:49:55.665] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:55.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:164:0) after 1m0s
[08:50:55.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:164:0)
[08:50:55.716] Timer tick, asking Buildbucket for the build status
[08:50:57.683] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:57.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:165:0) after 1m0s
[08:51:57.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:165:0)
[08:51:57.748] Timer tick, asking Buildbucket for the build status
[08:51:57.979] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:57.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:166:0) after 1m0s
[08:52:58.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:166:0)
[08:52:58.185] Timer tick, asking Buildbucket for the build status
[08:53:01.009] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:01.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:167:0) after 1m0s
[08:54:01.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:167:0)
[08:54:01.108] Timer tick, asking Buildbucket for the build status
[08:54:02.738] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:02.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:168:0) after 1m0s
[08:55:02.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:168:0)
[08:55:02.866] Timer tick, asking Buildbucket for the build status
[08:55:06.242] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:169:0) after 1m0s
[08:56:06.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:169:0)
[08:56:06.304] Timer tick, asking Buildbucket for the build status
[08:56:07.216] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:07.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:170:0) after 1m0s
[08:57:07.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:170:0)
[08:57:07.357] Timer tick, asking Buildbucket for the build status
[08:57:10.184] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:171:0) after 1m0s
[08:58:10.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:171:0)
[08:58:10.230] Timer tick, asking Buildbucket for the build status
[08:58:10.445] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:10.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:172:0) after 1m0s
[08:59:10.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:172:0)
[08:59:10.442] Timer tick, asking Buildbucket for the build status
[08:59:11.701] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:173:0) after 1m0s
[09:00:11.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:173:0)
[09:00:11.681] Timer tick, asking Buildbucket for the build status
[09:00:17.146] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:17.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:174:0) after 1m0s
[09:01:17.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:174:0)
[09:01:17.184] Timer tick, asking Buildbucket for the build status
[09:01:20.378] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:20.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:175:0) after 1m0s
[09:02:20.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:175:0)
[09:02:20.429] Timer tick, asking Buildbucket for the build status
[09:02:23.444] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:23.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:176:0) after 1m0s
[09:03:23.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:176:0)
[09:03:23.473] Timer tick, asking Buildbucket for the build status
[09:03:25.639] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:25.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:177:0) after 1m0s
[09:04:25.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:177:0)
[09:04:25.756] Timer tick, asking Buildbucket for the build status
[09:04:27.381] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:27.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:178:0) after 1m0s
[09:05:27.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:178:0)
[09:05:27.475] Timer tick, asking Buildbucket for the build status
[09:05:27.710] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:27.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:179:0) after 1m0s
[09:06:27.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:179:0)
[09:06:27.874] Timer tick, asking Buildbucket for the build status
[09:06:29.107] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:29.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:180:0) after 1m0s
[09:07:29.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:180:0)
[09:07:29.119] Timer tick, asking Buildbucket for the build status
[09:07:30.044] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:30.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:181:0) after 1m0s
[09:08:30.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:181:0)
[09:08:30.221] Timer tick, asking Buildbucket for the build status
[09:08:31.021] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:31.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:182:0) after 1m0s
[09:09:31.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:182:0)
[09:09:31.095] Timer tick, asking Buildbucket for the build status
[09:09:33.063] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:33.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:183:0) after 1m0s
[09:10:33.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:183:0)
[09:10:33.147] Timer tick, asking Buildbucket for the build status
[09:10:33.367] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:33.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:184:0) after 1m0s
[09:11:33.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:184:0)
[09:11:33.397] Timer tick, asking Buildbucket for the build status
[09:11:35.355] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:35.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:185:0) after 1m0s
[09:12:35.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:185:0)
[09:12:35.409] Timer tick, asking Buildbucket for the build status
[09:12:35.785] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:35.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:186:0) after 1m0s
[09:13:35.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:186:0)
[09:13:35.788] Timer tick, asking Buildbucket for the build status
[09:13:36.562] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:36.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:187:0) after 1m0s
[09:14:36.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:187:0)
[09:14:36.677] Timer tick, asking Buildbucket for the build status
[09:14:37.306] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:37.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:188:0) after 1m0s
[09:15:37.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:188:0)
[09:15:37.372] Timer tick, asking Buildbucket for the build status
[09:15:37.798] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:37.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:189:0) after 1m0s
[09:16:37.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:189:0)
[09:16:37.833] Timer tick, asking Buildbucket for the build status
[09:16:38.331] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:38.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:190:0) after 1m0s
[09:17:38.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:190:0)
[09:17:38.387] Timer tick, asking Buildbucket for the build status
[09:17:39.241] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:39.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:191:0) after 1m0s
[09:18:39.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:191:0)
[09:18:39.365] Timer tick, asking Buildbucket for the build status
[09:18:40.387] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:40.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:192:0) after 1m0s
[09:19:40.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:192:0)
[09:19:40.415] Timer tick, asking Buildbucket for the build status
[09:19:41.401] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:41.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:193:0) after 1m0s
[09:20:41.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:193:0)
[09:20:41.485] Timer tick, asking Buildbucket for the build status
[09:20:47.534] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:47.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:194:0) after 1m0s
[09:21:47.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:194:0)
[09:21:47.550] Timer tick, asking Buildbucket for the build status
[09:21:47.777] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:47.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:195:0) after 1m0s
[09:22:47.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:195:0)
[09:22:47.808] Timer tick, asking Buildbucket for the build status
[09:22:48.767] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:48.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:196:0) after 1m0s
[09:23:48.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:196:0)
[09:23:48.808] Timer tick, asking Buildbucket for the build status
[09:23:49.574] Build 8902545158481132896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:49.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067975221008773776:197:0) after 1m0s
[09:24:08.427] Received PubSub notification, asking Buildbucket for the build status
[09:24:09.261] Build 8902545158481132896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:24:09.261] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1568280247467554",
"created_by": "project:chromium",
"created_ts": "1568268353917435",
"id": "8902545158481132896",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e274f2396dae7d685e725c93745f2828739f0972\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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-y5mg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14697, \"got_angle_revision\": \"f421e0e33e6656b30ddbda920395f2657c619d22\", \"got_dawn_revision\": \"f35dcfe60a62cfb76ee557edd4d5bad0068f2850\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"e274f2396dae7d685e725c93745f2828739f0972\", \"got_revision_cp\": \"refs/heads/master@{#695938}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9f468cebfcd80803f01fa20917e4cb8c6c1a6365\", \"got_v8_revision_cp\": \"refs/heads/7.9.18@{#1}\", \"got_webrtc_revision\": \"e373bb6ea58b0bfeafca9c3685a41b3b670c4d28\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29161}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e274f2396dae7d685e725c93745f2828739f0972\"}, \"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-y5mg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"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\": [\"4433-55fd66b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1568269276066347",
"status": "COMPLETED",
"status_changed_ts": "1568280247893423",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14697",
"builder:Windows deterministic",
"buildset:commit/git/e274f2396dae7d685e725c93745f2828739f0972",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e274f2396dae7d685e725c93745f2828739f0972",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067975221008773776",
"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/8902545158481132896/+/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:473ce58ea0eae810",
"user_agent:luci-scheduler"
],
"updated_ts": "1568280247897294",
"url": "https://ci.chromium.org/b/8902545158481132896",
"utcnow_ts": "1568280249239049"
}
}
[09:24:09.261] Invocation finished in 3h18m17.138087097s with status SUCCEEDED