[04:17:34.159] New invocation is queued and will start shortly
[04:17:35.416] Starting the invocation (attempt 1)
[04:17:35.448] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:17:35.448] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:17:35.449] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057382189568532976",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"34721265a0a2b0b270383145f0e434a8e66126cf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9057382189568532976",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/34721265a0a2b0b270383145f0e434a8e66126cf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34721265a0a2b0b270383145f0e434a8e66126cf",
"gitiles_ref:refs/heads/master"
]
}
[04:17:36.418] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578370655612945",
"id": "8891952127379316400",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"34721265a0a2b0b270383145f0e434a8e66126cf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578370656237409",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15642",
"builder:Windows deterministic",
"buildset:commit/git/34721265a0a2b0b270383145f0e434a8e66126cf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34721265a0a2b0b270383145f0e434a8e66126cf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057382189568532976",
"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/8891952127379316400/+/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": "1578370656237553",
"url": "https://ci.chromium.org/b/8891952127379316400",
"utcnow_ts": "1578370656408124"
}
}
[04:17:36.418] Task URL: https://ci.chromium.org/b/8891952127379316400
[04:17:36.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:2:0) after 1m0s
[04:18:36.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:2:0)
[04:18:36.463] Timer tick, asking Buildbucket for the build status
[04:18:36.845] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:36.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:3:0) after 1m0s
[04:19:36.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:3:0)
[04:19:36.862] Timer tick, asking Buildbucket for the build status
[04:19:39.136] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:39.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:4:0) after 1m0s
[04:20:39.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:4:0)
[04:20:39.137] Timer tick, asking Buildbucket for the build status
[04:20:39.608] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:39.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:5:0) after 1m0s
[04:21:39.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:5:0)
[04:21:39.628] Timer tick, asking Buildbucket for the build status
[04:21:40.536] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:40.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:6:0) after 1m0s
[04:22:40.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:6:0)
[04:22:40.590] Timer tick, asking Buildbucket for the build status
[04:22:40.760] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:40.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:7:0) after 1m0s
[04:23:40.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:7:0)
[04:23:40.789] Timer tick, asking Buildbucket for the build status
[04:23:40.983] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:8:0) after 1m0s
[04:24:41.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:8:0)
[04:24:41.075] Timer tick, asking Buildbucket for the build status
[04:24:41.351] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:41.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:9:0) after 1m0s
[04:25:41.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:9:0)
[04:25:41.360] Timer tick, asking Buildbucket for the build status
[04:25:41.976] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:41.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:10:0) after 1m0s
[04:26:42.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:10:0)
[04:26:42.098] Timer tick, asking Buildbucket for the build status
[04:26:42.997] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:42.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:11:0) after 1m0s
[04:27:43.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:11:0)
[04:27:43.016] Timer tick, asking Buildbucket for the build status
[04:27:45.382] Build 8891952127379316400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:45.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:12:0) after 1m0s
[04:28:13.297] Received PubSub notification, asking Buildbucket for the build status
[04:28:13.454] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:45.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:12:0)
[04:28:45.461] Timer tick, asking Buildbucket for the build status
[04:28:46.341] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:46.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:14:0) after 1m0s
[04:29:46.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:14:0)
[04:29:46.370] Timer tick, asking Buildbucket for the build status
[04:29:46.678] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:46.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:15:0) after 1m0s
[04:30:46.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:15:0)
[04:30:46.663] Timer tick, asking Buildbucket for the build status
[04:30:46.847] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:46.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:16:0) after 1m0s
[04:31:46.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:16:0)
[04:31:46.881] Timer tick, asking Buildbucket for the build status
[04:31:47.069] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:47.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:17:0) after 1m0s
[04:32:47.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:17:0)
[04:32:47.103] Timer tick, asking Buildbucket for the build status
[04:32:47.531] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:47.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:18:0) after 1m0s
[04:33:47.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:18:0)
[04:33:47.571] Timer tick, asking Buildbucket for the build status
[04:33:48.255] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:48.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:19:0) after 1m0s
[04:34:48.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:19:0)
[04:34:48.359] Timer tick, asking Buildbucket for the build status
[04:34:48.905] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:48.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:20:0) after 1m0s
[04:35:48.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:20:0)
[04:35:48.987] Timer tick, asking Buildbucket for the build status
[04:35:49.152] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:49.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:21:0) after 1m0s
[04:36:49.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:21:0)
[04:36:49.181] Timer tick, asking Buildbucket for the build status
[04:36:49.358] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:49.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:22:0) after 1m0s
[04:37:49.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:22:0)
[04:37:49.376] Timer tick, asking Buildbucket for the build status
[04:37:49.850] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:49.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:23:0) after 1m0s
[04:38:49.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:23:0)
[04:38:49.999] Timer tick, asking Buildbucket for the build status
[04:38:50.255] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:24:0) after 1m0s
[04:39:50.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:24:0)
[04:39:50.335] Timer tick, asking Buildbucket for the build status
[04:39:51.847] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:51.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:25:0) after 1m0s
[04:40:51.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:25:0)
[04:40:51.892] Timer tick, asking Buildbucket for the build status
[04:40:52.053] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:26:0) after 1m0s
[04:41:52.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:26:0)
[04:41:52.075] Timer tick, asking Buildbucket for the build status
[04:41:52.317] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:52.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:27:0) after 1m0s
[04:42:52.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:27:0)
[04:42:52.368] Timer tick, asking Buildbucket for the build status
[04:42:53.764] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:53.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:28:0) after 1m0s
[04:43:53.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:28:0)
[04:43:53.875] Timer tick, asking Buildbucket for the build status
[04:43:54.780] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:54.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:29:0) after 1m0s
[04:44:54.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:29:0)
[04:44:54.810] Timer tick, asking Buildbucket for the build status
[04:44:55.086] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:30:0) after 1m0s
[04:45:55.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:30:0)
[04:45:55.157] Timer tick, asking Buildbucket for the build status
[04:45:55.265] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:55.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:31:0) after 1m0s
[04:46:55.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:31:0)
[04:46:55.381] Timer tick, asking Buildbucket for the build status
[04:46:55.587] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:55.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:32:0) after 1m0s
[04:47:55.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:32:0)
[04:47:55.576] Timer tick, asking Buildbucket for the build status
[04:47:55.888] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:55.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:33:0) after 1m0s
[04:48:55.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:33:0)
[04:48:55.965] Timer tick, asking Buildbucket for the build status
[04:48:56.241] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:56.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:34:0) after 1m0s
[04:49:56.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:34:0)
[04:49:56.400] Timer tick, asking Buildbucket for the build status
[04:49:56.694] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:56.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:35:0) after 1m0s
[04:50:56.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:35:0)
[04:50:56.887] Timer tick, asking Buildbucket for the build status
[04:50:57.080] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:57.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:36:0) after 1m0s
[04:51:57.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:36:0)
[04:51:57.336] Timer tick, asking Buildbucket for the build status
[04:51:57.615] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:57.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:37:0) after 1m0s
[04:52:57.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:37:0)
[04:52:57.665] Timer tick, asking Buildbucket for the build status
[04:52:57.861] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:57.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:38:0) after 1m0s
[04:53:57.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:38:0)
[04:53:57.989] Timer tick, asking Buildbucket for the build status
[04:53:58.118] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:58.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:39:0) after 1m0s
[04:54:58.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:39:0)
[04:54:58.276] Timer tick, asking Buildbucket for the build status
[04:54:58.462] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:58.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:40:0) after 1m0s
[04:55:58.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:40:0)
[04:55:58.443] Timer tick, asking Buildbucket for the build status
[04:55:58.618] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:58.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:41:0) after 1m0s
[04:56:58.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:41:0)
[04:56:58.662] Timer tick, asking Buildbucket for the build status
[04:56:59.581] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:59.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:42:0) after 1m0s
[04:57:59.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:42:0)
[04:57:59.707] Timer tick, asking Buildbucket for the build status
[04:58:00.241] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:00.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:43:0) after 1m0s
[04:59:00.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:43:0)
[04:59:00.433] Timer tick, asking Buildbucket for the build status
[04:59:00.557] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:00.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:44:0) after 1m0s
[05:00:00.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:44:0)
[05:00:00.707] Timer tick, asking Buildbucket for the build status
[05:00:00.987] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:00.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:45:0) after 1m0s
[05:01:01.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:45:0)
[05:01:01.154] Timer tick, asking Buildbucket for the build status
[05:01:01.496] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:01.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:46:0) after 1m0s
[05:02:01.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:46:0)
[05:02:01.768] Timer tick, asking Buildbucket for the build status
[05:02:02.431] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:02.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:47:0) after 1m0s
[05:03:02.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:47:0)
[05:03:02.484] Timer tick, asking Buildbucket for the build status
[05:03:03.040] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:03.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:48:0) after 1m0s
[05:04:03.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:48:0)
[05:04:03.101] Timer tick, asking Buildbucket for the build status
[05:04:03.580] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:03.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:49:0) after 1m0s
[05:05:03.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:49:0)
[05:05:03.643] Timer tick, asking Buildbucket for the build status
[05:05:03.980] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:03.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:50:0) after 1m0s
[05:06:03.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:50:0)
[05:06:03.981] Timer tick, asking Buildbucket for the build status
[05:06:04.192] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:04.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:51:0) after 1m0s
[05:07:04.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:51:0)
[05:07:04.253] Timer tick, asking Buildbucket for the build status
[05:07:04.864] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:04.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:52:0) after 1m0s
[05:08:04.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:52:0)
[05:08:04.929] Timer tick, asking Buildbucket for the build status
[05:08:06.060] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:06.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:53:0) after 1m0s
[05:09:06.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:53:0)
[05:09:06.208] Timer tick, asking Buildbucket for the build status
[05:09:06.354] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:06.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:54:0) after 1m0s
[05:10:06.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:54:0)
[05:10:06.448] Timer tick, asking Buildbucket for the build status
[05:10:06.668] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:06.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:55:0) after 1m0s
[05:11:06.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:55:0)
[05:11:06.685] Timer tick, asking Buildbucket for the build status
[05:11:06.878] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:06.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:56:0) after 1m0s
[05:12:06.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:56:0)
[05:12:06.904] Timer tick, asking Buildbucket for the build status
[05:12:07.567] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:07.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:57:0) after 1m0s
[05:13:07.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:57:0)
[05:13:07.634] Timer tick, asking Buildbucket for the build status
[05:13:07.958] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:07.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:58:0) after 1m0s
[05:14:08.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:58:0)
[05:14:08.023] Timer tick, asking Buildbucket for the build status
[05:14:08.402] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:08.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:59:0) after 1m0s
[05:15:08.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:59:0)
[05:15:08.481] Timer tick, asking Buildbucket for the build status
[05:15:09.369] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:09.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:60:0) after 1m0s
[05:16:09.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:60:0)
[05:16:09.378] Timer tick, asking Buildbucket for the build status
[05:16:09.600] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:09.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:61:0) after 1m0s
[05:17:09.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:61:0)
[05:17:09.845] Timer tick, asking Buildbucket for the build status
[05:17:10.137] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:10.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:62:0) after 1m0s
[05:18:10.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:62:0)
[05:18:10.174] Timer tick, asking Buildbucket for the build status
[05:18:10.480] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:10.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:63:0) after 1m0s
[05:19:10.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:63:0)
[05:19:10.508] Timer tick, asking Buildbucket for the build status
[05:19:10.688] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:10.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:64:0) after 1m0s
[05:20:10.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:64:0)
[05:20:10.740] Timer tick, asking Buildbucket for the build status
[05:20:11.171] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:11.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:65:0) after 1m0s
[05:21:11.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:65:0)
[05:21:11.284] Timer tick, asking Buildbucket for the build status
[05:21:11.627] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:11.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:66:0) after 1m0s
[05:22:11.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:66:0)
[05:22:11.652] Timer tick, asking Buildbucket for the build status
[05:22:12.023] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:67:0) after 1m0s
[05:23:12.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:67:0)
[05:23:12.099] Timer tick, asking Buildbucket for the build status
[05:23:12.272] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:12.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:68:0) after 1m0s
[05:24:12.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:68:0)
[05:24:12.528] Timer tick, asking Buildbucket for the build status
[05:24:12.683] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:12.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:69:0) after 1m0s
[05:25:12.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:69:0)
[05:25:12.709] Timer tick, asking Buildbucket for the build status
[05:25:12.879] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:12.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:70:0) after 1m0s
[05:26:12.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:70:0)
[05:26:12.970] Timer tick, asking Buildbucket for the build status
[05:26:13.212] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:13.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:71:0) after 1m0s
[05:27:13.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:71:0)
[05:27:13.273] Timer tick, asking Buildbucket for the build status
[05:27:13.529] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:13.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:72:0) after 1m0s
[05:28:13.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:72:0)
[05:28:13.735] Timer tick, asking Buildbucket for the build status
[05:28:14.295] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:14.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:73:0) after 1m0s
[05:29:14.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:73:0)
[05:29:14.518] Timer tick, asking Buildbucket for the build status
[05:29:14.666] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:74:0) after 1m0s
[05:30:14.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:74:0)
[05:30:14.661] Timer tick, asking Buildbucket for the build status
[05:30:14.826] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:14.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:75:0) after 1m0s
[05:31:14.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:75:0)
[05:31:14.896] Timer tick, asking Buildbucket for the build status
[05:31:15.396] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:15.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:76:0) after 1m0s
[05:32:15.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:76:0)
[05:32:15.465] Timer tick, asking Buildbucket for the build status
[05:32:16.087] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:77:0) after 1m0s
[05:33:16.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:77:0)
[05:33:16.116] Timer tick, asking Buildbucket for the build status
[05:33:16.873] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:78:0) after 1m0s
[05:34:16.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:78:0)
[05:34:16.916] Timer tick, asking Buildbucket for the build status
[05:34:17.081] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:17.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:79:0) after 1m0s
[05:35:17.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:79:0)
[05:35:17.129] Timer tick, asking Buildbucket for the build status
[05:35:17.289] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:17.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:80:0) after 1m0s
[05:36:17.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:80:0)
[05:36:17.362] Timer tick, asking Buildbucket for the build status
[05:36:17.887] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:17.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:81:0) after 1m0s
[05:37:17.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:81:0)
[05:37:17.969] Timer tick, asking Buildbucket for the build status
[05:37:18.990] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:82:0) after 1m0s
[05:38:19.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:82:0)
[05:38:19.074] Timer tick, asking Buildbucket for the build status
[05:38:19.328] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:83:0) after 1m0s
[05:39:19.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:83:0)
[05:39:19.341] Timer tick, asking Buildbucket for the build status
[05:39:19.558] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:19.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:84:0) after 1m0s
[05:40:19.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:84:0)
[05:40:19.566] Timer tick, asking Buildbucket for the build status
[05:40:20.351] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:20.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:85:0) after 1m0s
[05:41:20.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:85:0)
[05:41:20.475] Timer tick, asking Buildbucket for the build status
[05:41:21.109] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:21.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:86:0) after 1m0s
[05:42:21.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:86:0)
[05:42:21.192] Timer tick, asking Buildbucket for the build status
[05:42:21.556] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:21.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:87:0) after 1m0s
[05:43:21.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:87:0)
[05:43:21.650] Timer tick, asking Buildbucket for the build status
[05:43:22.379] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:22.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:88:0) after 1m0s
[05:44:22.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:88:0)
[05:44:22.444] Timer tick, asking Buildbucket for the build status
[05:44:22.589] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:22.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:89:0) after 1m0s
[05:45:22.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:89:0)
[05:45:22.624] Timer tick, asking Buildbucket for the build status
[05:45:22.780] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:90:0) after 1m0s
[05:46:22.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:90:0)
[05:46:22.924] Timer tick, asking Buildbucket for the build status
[05:46:23.090] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:23.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:91:0) after 1m0s
[05:47:23.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:91:0)
[05:47:23.116] Timer tick, asking Buildbucket for the build status
[05:47:23.411] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:23.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:92:0) after 1m0s
[05:48:23.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:92:0)
[05:48:23.470] Timer tick, asking Buildbucket for the build status
[05:48:23.697] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:23.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:93:0) after 1m0s
[05:49:24.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:93:0)
[05:49:24.034] Timer tick, asking Buildbucket for the build status
[05:49:24.376] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:24.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:94:0) after 1m0s
[05:50:24.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:94:0)
[05:50:24.461] Timer tick, asking Buildbucket for the build status
[05:50:24.629] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:24.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:95:0) after 1m0s
[05:51:24.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:95:0)
[05:51:24.661] Timer tick, asking Buildbucket for the build status
[05:51:24.795] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:24.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:96:0) after 1m0s
[05:52:24.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:96:0)
[05:52:24.857] Timer tick, asking Buildbucket for the build status
[05:52:25.048] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:25.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:97:0) after 1m0s
[05:53:25.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:97:0)
[05:53:25.078] Timer tick, asking Buildbucket for the build status
[05:53:25.716] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:25.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:98:0) after 1m0s
[05:54:25.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:98:0)
[05:54:25.714] Timer tick, asking Buildbucket for the build status
[05:54:26.033] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:99:0) after 1m0s
[05:55:26.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:99:0)
[05:55:26.062] Timer tick, asking Buildbucket for the build status
[05:55:26.350] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:26.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:100:0) after 1m0s
[05:56:26.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:100:0)
[05:56:26.379] Timer tick, asking Buildbucket for the build status
[05:56:26.541] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:26.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:101:0) after 1m0s
[05:57:26.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:101:0)
[05:57:26.575] Timer tick, asking Buildbucket for the build status
[05:57:26.947] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:26.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:102:0) after 1m0s
[05:58:26.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:102:0)
[05:58:26.976] Timer tick, asking Buildbucket for the build status
[05:58:27.144] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:27.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:103:0) after 1m0s
[05:59:27.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:103:0)
[05:59:27.239] Timer tick, asking Buildbucket for the build status
[05:59:27.415] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:27.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:104:0) after 1m0s
[06:00:27.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:104:0)
[06:00:27.473] Timer tick, asking Buildbucket for the build status
[06:00:27.640] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:27.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:105:0) after 1m0s
[06:01:27.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:105:0)
[06:01:27.706] Timer tick, asking Buildbucket for the build status
[06:01:28.172] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:28.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:106:0) after 1m0s
[06:02:28.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:106:0)
[06:02:28.179] Timer tick, asking Buildbucket for the build status
[06:02:28.523] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:28.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:107:0) after 1m0s
[06:03:28.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:107:0)
[06:03:28.574] Timer tick, asking Buildbucket for the build status
[06:03:28.732] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:28.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:108:0) after 1m0s
[06:04:28.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:108:0)
[06:04:28.826] Timer tick, asking Buildbucket for the build status
[06:04:29.037] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:109:0) after 1m0s
[06:05:29.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:109:0)
[06:05:29.076] Timer tick, asking Buildbucket for the build status
[06:05:29.574] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:29.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:110:0) after 1m0s
[06:06:29.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:110:0)
[06:06:29.638] Timer tick, asking Buildbucket for the build status
[06:06:29.926] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:29.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:111:0) after 1m0s
[06:07:30.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:111:0)
[06:07:30.027] Timer tick, asking Buildbucket for the build status
[06:07:30.255] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:112:0) after 1m0s
[06:08:30.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:112:0)
[06:08:30.334] Timer tick, asking Buildbucket for the build status
[06:08:30.683] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:30.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:113:0) after 1m0s
[06:09:30.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:113:0)
[06:09:30.744] Timer tick, asking Buildbucket for the build status
[06:09:31.351] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:31.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:114:0) after 1m0s
[06:10:31.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:114:0)
[06:10:31.432] Timer tick, asking Buildbucket for the build status
[06:10:31.824] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:31.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:115:0) after 1m0s
[06:11:31.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:115:0)
[06:11:31.864] Timer tick, asking Buildbucket for the build status
[06:11:32.182] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:32.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:116:0) after 1m0s
[06:12:32.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:116:0)
[06:12:32.301] Timer tick, asking Buildbucket for the build status
[06:12:33.279] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:33.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:117:0) after 1m0s
[06:13:33.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:117:0)
[06:13:33.347] Timer tick, asking Buildbucket for the build status
[06:13:33.714] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:33.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:118:0) after 1m0s
[06:14:33.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:118:0)
[06:14:33.810] Timer tick, asking Buildbucket for the build status
[06:14:34.582] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:34.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:119:0) after 1m0s
[06:15:34.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:119:0)
[06:15:34.685] Timer tick, asking Buildbucket for the build status
[06:15:34.859] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:120:0) after 1m0s
[06:16:34.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:120:0)
[06:16:34.963] Timer tick, asking Buildbucket for the build status
[06:16:35.309] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:35.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:121:0) after 1m0s
[06:17:35.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:121:0)
[06:17:35.367] Timer tick, asking Buildbucket for the build status
[06:17:35.768] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:35.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:122:0) after 1m0s
[06:18:35.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:122:0)
[06:18:35.823] Timer tick, asking Buildbucket for the build status
[06:18:35.992] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:35.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:123:0) after 1m0s
[06:19:36.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:123:0)
[06:19:36.045] Timer tick, asking Buildbucket for the build status
[06:19:36.299] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:36.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:124:0) after 1m0s
[06:20:36.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:124:0)
[06:20:36.411] Timer tick, asking Buildbucket for the build status
[06:20:36.702] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:125:0) after 1m0s
[06:21:36.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:125:0)
[06:21:36.697] Timer tick, asking Buildbucket for the build status
[06:21:37.007] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:37.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:126:0) after 1m0s
[06:22:37.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:126:0)
[06:22:37.084] Timer tick, asking Buildbucket for the build status
[06:22:37.249] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:37.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:127:0) after 1m0s
[06:23:37.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:127:0)
[06:23:37.284] Timer tick, asking Buildbucket for the build status
[06:23:37.493] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:37.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:128:0) after 1m0s
[06:24:37.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:128:0)
[06:24:37.530] Timer tick, asking Buildbucket for the build status
[06:24:37.760] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:37.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:129:0) after 1m0s
[06:25:37.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:129:0)
[06:25:37.858] Timer tick, asking Buildbucket for the build status
[06:25:38.064] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:38.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:130:0) after 1m0s
[06:26:38.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:130:0)
[06:26:38.106] Timer tick, asking Buildbucket for the build status
[06:26:38.354] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:38.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:131:0) after 1m0s
[06:27:38.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:131:0)
[06:27:38.361] Timer tick, asking Buildbucket for the build status
[06:27:38.665] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:38.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:132:0) after 1m0s
[06:28:38.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:132:0)
[06:28:38.708] Timer tick, asking Buildbucket for the build status
[06:28:38.941] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:38.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:133:0) after 1m0s
[06:29:38.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:133:0)
[06:29:38.970] Timer tick, asking Buildbucket for the build status
[06:29:39.319] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:39.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:134:0) after 1m0s
[06:30:39.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:134:0)
[06:30:39.334] Timer tick, asking Buildbucket for the build status
[06:30:39.521] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:39.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:135:0) after 1m0s
[06:31:39.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:135:0)
[06:31:39.590] Timer tick, asking Buildbucket for the build status
[06:31:39.773] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:39.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:136:0) after 1m0s
[06:32:39.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:136:0)
[06:32:39.948] Timer tick, asking Buildbucket for the build status
[06:32:40.237] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:40.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:137:0) after 1m0s
[06:33:40.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:137:0)
[06:33:40.321] Timer tick, asking Buildbucket for the build status
[06:33:40.466] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:40.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:138:0) after 1m0s
[06:34:40.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:138:0)
[06:34:40.502] Timer tick, asking Buildbucket for the build status
[06:34:40.763] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:40.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:139:0) after 1m0s
[06:35:40.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:139:0)
[06:35:40.904] Timer tick, asking Buildbucket for the build status
[06:35:41.132] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:140:0) after 1m0s
[06:36:41.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:140:0)
[06:36:41.209] Timer tick, asking Buildbucket for the build status
[06:36:41.415] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:41.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:141:0) after 1m0s
[06:37:41.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:141:0)
[06:37:41.460] Timer tick, asking Buildbucket for the build status
[06:37:41.640] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:41.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:142:0) after 1m0s
[06:38:41.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:142:0)
[06:38:41.665] Timer tick, asking Buildbucket for the build status
[06:38:42.156] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:42.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:143:0) after 1m0s
[06:39:42.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:143:0)
[06:39:42.267] Timer tick, asking Buildbucket for the build status
[06:39:42.492] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:144:0) after 1m0s
[06:40:42.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:144:0)
[06:40:42.527] Timer tick, asking Buildbucket for the build status
[06:40:42.781] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:42.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:145:0) after 1m0s
[06:41:42.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:145:0)
[06:41:42.831] Timer tick, asking Buildbucket for the build status
[06:41:43.173] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:43.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:146:0) after 1m0s
[06:42:43.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:146:0)
[06:42:43.199] Timer tick, asking Buildbucket for the build status
[06:42:43.836] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:43.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:147:0) after 1m0s
[06:43:43.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:147:0)
[06:43:43.896] Timer tick, asking Buildbucket for the build status
[06:43:45.003] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:45.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:148:0) after 1m0s
[06:44:45.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:148:0)
[06:44:45.027] Timer tick, asking Buildbucket for the build status
[06:44:45.624] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:45.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:149:0) after 1m0s
[06:45:45.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:149:0)
[06:45:45.805] Timer tick, asking Buildbucket for the build status
[06:45:46.136] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:46.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:150:0) after 1m0s
[06:46:46.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:150:0)
[06:46:46.183] Timer tick, asking Buildbucket for the build status
[06:46:46.342] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:46.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:151:0) after 1m0s
[06:47:46.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:151:0)
[06:47:46.372] Timer tick, asking Buildbucket for the build status
[06:47:46.547] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:46.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:152:0) after 1m0s
[06:48:46.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:152:0)
[06:48:46.581] Timer tick, asking Buildbucket for the build status
[06:48:46.903] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:153:0) after 1m0s
[06:49:46.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:153:0)
[06:49:46.932] Timer tick, asking Buildbucket for the build status
[06:49:47.138] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:47.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:154:0) after 1m0s
[06:50:47.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:154:0)
[06:50:47.179] Timer tick, asking Buildbucket for the build status
[06:50:47.325] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:47.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:155:0) after 1m0s
[06:51:47.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:155:0)
[06:51:47.355] Timer tick, asking Buildbucket for the build status
[06:51:48.332] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:48.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:156:0) after 1m0s
[06:52:48.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:156:0)
[06:52:48.394] Timer tick, asking Buildbucket for the build status
[06:52:48.654] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:157:0) after 1m0s
[06:53:48.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:157:0)
[06:53:48.733] Timer tick, asking Buildbucket for the build status
[06:53:48.878] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:48.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:158:0) after 1m0s
[06:54:48.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:158:0)
[06:54:48.936] Timer tick, asking Buildbucket for the build status
[06:54:49.243] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:49.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:159:0) after 1m0s
[06:55:49.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:159:0)
[06:55:49.307] Timer tick, asking Buildbucket for the build status
[06:55:49.499] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:49.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:160:0) after 1m0s
[06:56:49.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:160:0)
[06:56:49.678] Timer tick, asking Buildbucket for the build status
[06:56:49.865] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:49.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:161:0) after 1m0s
[06:57:49.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:161:0)
[06:57:49.972] Timer tick, asking Buildbucket for the build status
[06:57:50.258] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:50.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:162:0) after 1m0s
[06:58:50.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:162:0)
[06:58:50.320] Timer tick, asking Buildbucket for the build status
[06:58:51.053] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:51.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:163:0) after 1m0s
[06:59:51.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:163:0)
[06:59:51.232] Timer tick, asking Buildbucket for the build status
[06:59:51.408] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:51.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:164:0) after 1m0s
[07:00:51.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:164:0)
[07:00:51.516] Timer tick, asking Buildbucket for the build status
[07:00:51.744] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:51.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:165:0) after 1m0s
[07:01:51.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:165:0)
[07:01:51.849] Timer tick, asking Buildbucket for the build status
[07:01:51.989] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:51.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:166:0) after 1m0s
[07:02:52.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:166:0)
[07:02:52.015] Timer tick, asking Buildbucket for the build status
[07:02:52.272] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:167:0) after 1m0s
[07:03:52.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:167:0)
[07:03:52.410] Timer tick, asking Buildbucket for the build status
[07:03:52.530] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:52.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:168:0) after 1m0s
[07:04:52.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:168:0)
[07:04:52.671] Timer tick, asking Buildbucket for the build status
[07:04:54.017] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:54.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:169:0) after 1m0s
[07:05:54.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:169:0)
[07:05:54.246] Timer tick, asking Buildbucket for the build status
[07:05:54.445] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:54.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:170:0) after 1m0s
[07:06:54.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:170:0)
[07:06:54.485] Timer tick, asking Buildbucket for the build status
[07:06:56.147] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:56.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:171:0) after 1m0s
[07:07:56.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:171:0)
[07:07:56.233] Timer tick, asking Buildbucket for the build status
[07:07:56.388] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:56.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:172:0) after 1m0s
[07:08:56.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:172:0)
[07:08:56.560] Timer tick, asking Buildbucket for the build status
[07:08:56.865] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:56.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:173:0) after 1m0s
[07:09:57.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:173:0)
[07:09:57.074] Timer tick, asking Buildbucket for the build status
[07:09:57.317] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:57.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:174:0) after 1m0s
[07:10:57.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:174:0)
[07:10:57.324] Timer tick, asking Buildbucket for the build status
[07:10:57.480] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:57.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:175:0) after 1m0s
[07:11:57.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:175:0)
[07:11:57.642] Timer tick, asking Buildbucket for the build status
[07:11:58.376] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:58.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:176:0) after 1m0s
[07:12:58.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:176:0)
[07:12:58.375] Timer tick, asking Buildbucket for the build status
[07:12:58.867] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:58.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:177:0) after 1m0s
[07:13:58.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:177:0)
[07:13:58.966] Timer tick, asking Buildbucket for the build status
[07:13:59.401] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:59.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:178:0) after 1m0s
[07:14:59.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:178:0)
[07:14:59.459] Timer tick, asking Buildbucket for the build status
[07:15:00.714] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:00.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:179:0) after 1m0s
[07:16:00.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:179:0)
[07:16:00.761] Timer tick, asking Buildbucket for the build status
[07:16:00.973] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:00.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:180:0) after 1m0s
[07:17:01.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:180:0)
[07:17:01.025] Timer tick, asking Buildbucket for the build status
[07:17:01.345] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:01.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:181:0) after 1m0s
[07:18:01.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:181:0)
[07:18:01.445] Timer tick, asking Buildbucket for the build status
[07:18:01.796] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:182:0) after 1m0s
[07:19:01.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:182:0)
[07:19:01.830] Timer tick, asking Buildbucket for the build status
[07:19:02.108] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:02.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:183:0) after 1m0s
[07:20:02.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:183:0)
[07:20:02.255] Timer tick, asking Buildbucket for the build status
[07:20:02.416] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:02.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:184:0) after 1m0s
[07:21:02.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:184:0)
[07:21:02.494] Timer tick, asking Buildbucket for the build status
[07:21:02.744] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:02.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:185:0) after 1m0s
[07:22:02.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:185:0)
[07:22:02.868] Timer tick, asking Buildbucket for the build status
[07:22:03.179] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:03.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:186:0) after 1m0s
[07:23:03.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:186:0)
[07:23:03.218] Timer tick, asking Buildbucket for the build status
[07:23:03.388] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:03.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:187:0) after 1m0s
[07:24:03.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:187:0)
[07:24:03.443] Timer tick, asking Buildbucket for the build status
[07:24:03.644] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:03.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:188:0) after 1m0s
[07:25:03.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:188:0)
[07:25:03.803] Timer tick, asking Buildbucket for the build status
[07:25:04.213] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:04.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:189:0) after 1m0s
[07:26:04.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:189:0)
[07:26:04.373] Timer tick, asking Buildbucket for the build status
[07:26:04.897] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:04.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:190:0) after 1m0s
[07:27:04.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:190:0)
[07:27:04.968] Timer tick, asking Buildbucket for the build status
[07:27:05.148] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:05.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:191:0) after 1m0s
[07:28:05.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:191:0)
[07:28:05.182] Timer tick, asking Buildbucket for the build status
[07:28:05.760] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:05.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:192:0) after 1m0s
[07:29:05.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:192:0)
[07:29:05.810] Timer tick, asking Buildbucket for the build status
[07:29:06.554] Build 8891952127379316400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:06.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9057382189568532976:193:0) after 1m0s
[07:29:07.347] Received PubSub notification, asking Buildbucket for the build status
[07:29:07.548] Build 8891952127379316400: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:29:07.548] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578382146771614",
"created_by": "project:chromium",
"created_ts": "1578370655612945",
"failure_reason": "BUILD_FAILURE",
"id": "8891952127379316400",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"34721265a0a2b0b270383145f0e434a8e66126cf\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-pi3t\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15642, \"got_angle_revision\": \"f8ae5dc6d791be56962d8bc8f8c4ff5644ab0c99\", \"got_dawn_revision\": \"96f79f6db56b87150be2a12755fed10f91f574dc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"34721265a0a2b0b270383145f0e434a8e66126cf\", \"got_revision_cp\": \"refs/heads/master@{#728784}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"068dd89cab31091e2290c99bd8b6c721e1108bda\", \"got_v8_revision\": \"fcd83e09abfa01519851562f2441132dd747e8ff\", \"got_v8_revision_cp\": \"refs/heads/8.1.94@{#1}\", \"got_webrtc_revision\": \"cfe75c12ee04d17e7898ebc0a8ad1051b6627e53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30150}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"34721265a0a2b0b270383145f0e434a8e66126cf\"}, \"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-pi3t\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4733-6bd8c41\"], \"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": "1578371291354889",
"status": "COMPLETED",
"status_changed_ts": "1578371292747982",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15642",
"builder:Windows deterministic",
"buildset:commit/git/34721265a0a2b0b270383145f0e434a8e66126cf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34721265a0a2b0b270383145f0e434a8e66126cf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057382189568532976",
"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/8891952127379316400/+/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:49970ac1dd19c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1578382146853572",
"url": "https://ci.chromium.org/b/8891952127379316400",
"utcnow_ts": "1578382147538049"
}
}
[07:29:07.548] Invocation finished in 3h11m33.406832095s with status FAILED