[15:34:28.112] New invocation is queued and will start shortly
[15:34:29.190] Starting the invocation (attempt 1)
[15:34:29.234] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:34:29.234] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:34:29.234] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072831684007406416",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"5b37e51fec0e18fd1b0c168d6823da200d96a4a7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9072831684007406416",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"gitiles_ref:refs/heads/master"
]
}
[15:34:30.642] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563636869458102",
"id": "8907401621929586240",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b37e51fec0e18fd1b0c168d6823da200d96a4a7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563636870459471",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14187",
"builder:Windows deterministic",
"buildset:commit/git/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072831684007406416",
"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/8907401621929586240/+/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": "1563636870459644",
"url": "https://ci.chromium.org/b/8907401621929586240",
"utcnow_ts": "1563636870631361"
}
}
[15:34:30.642] Task URL: https://ci.chromium.org/b/8907401621929586240
[15:34:30.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:2:0) after 1m0s
[15:35:30.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:2:0)
[15:35:30.733] Timer tick, asking Buildbucket for the build status
[15:35:30.983] Build 8907401621929586240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:30.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:3:0) after 1m0s
[15:36:27.869] Received PubSub notification, asking Buildbucket for the build status
[15:36:28.037] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:3:0)
[15:36:31.017] Timer tick, asking Buildbucket for the build status
[15:36:31.178] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:5:0) after 1m0s
[15:37:31.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:5:0)
[15:37:31.249] Timer tick, asking Buildbucket for the build status
[15:37:31.873] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:31.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:6:0) after 1m0s
[15:38:31.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:6:0)
[15:38:31.846] Timer tick, asking Buildbucket for the build status
[15:38:31.945] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:31.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:7:0) after 1m0s
[15:39:31.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:7:0)
[15:39:31.968] Timer tick, asking Buildbucket for the build status
[15:39:32.355] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:8:0) after 1m0s
[15:40:32.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:8:0)
[15:40:32.424] Timer tick, asking Buildbucket for the build status
[15:40:33.264] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:33.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:9:0) after 1m0s
[15:41:33.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:9:0)
[15:41:33.328] Timer tick, asking Buildbucket for the build status
[15:41:33.580] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:33.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:10:0) after 1m0s
[15:42:33.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:10:0)
[15:42:33.558] Timer tick, asking Buildbucket for the build status
[15:42:35.346] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:35.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:11:0) after 1m0s
[15:43:35.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:11:0)
[15:43:35.385] Timer tick, asking Buildbucket for the build status
[15:43:35.691] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:35.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:12:0) after 1m0s
[15:44:35.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:12:0)
[15:44:35.777] Timer tick, asking Buildbucket for the build status
[15:44:36.342] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:36.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:13:0) after 1m0s
[15:45:36.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:13:0)
[15:45:36.431] Timer tick, asking Buildbucket for the build status
[15:45:36.635] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:36.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:14:0) after 1m0s
[15:46:36.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:14:0)
[15:46:36.655] Timer tick, asking Buildbucket for the build status
[15:46:37.048] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:37.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:15:0) after 1m0s
[15:47:37.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:15:0)
[15:47:37.094] Timer tick, asking Buildbucket for the build status
[15:47:37.306] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:37.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:16:0) after 1m0s
[15:48:37.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:16:0)
[15:48:37.327] Timer tick, asking Buildbucket for the build status
[15:48:37.448] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:37.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:17:0) after 1m0s
[15:49:37.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:17:0)
[15:49:37.481] Timer tick, asking Buildbucket for the build status
[15:49:37.850] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:37.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:18:0) after 1m0s
[15:50:37.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:18:0)
[15:50:37.876] Timer tick, asking Buildbucket for the build status
[15:50:39.192] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:39.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:19:0) after 1m0s
[15:51:39.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:19:0)
[15:51:39.369] Timer tick, asking Buildbucket for the build status
[15:51:39.642] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:39.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:20:0) after 1m0s
[15:52:39.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:20:0)
[15:52:39.781] Timer tick, asking Buildbucket for the build status
[15:52:40.051] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:40.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:21:0) after 1m0s
[15:53:40.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:21:0)
[15:53:40.146] Timer tick, asking Buildbucket for the build status
[15:53:41.410] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:22:0) after 1m0s
[15:54:41.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:22:0)
[15:54:41.528] Timer tick, asking Buildbucket for the build status
[15:54:41.654] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:41.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:23:0) after 1m0s
[15:55:41.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:23:0)
[15:55:41.857] Timer tick, asking Buildbucket for the build status
[15:55:42.746] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:42.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:24:0) after 1m0s
[15:56:42.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:24:0)
[15:56:42.823] Timer tick, asking Buildbucket for the build status
[15:56:43.483] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:43.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:25:0) after 1m0s
[15:57:43.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:25:0)
[15:57:43.633] Timer tick, asking Buildbucket for the build status
[15:57:45.042] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:45.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:26:0) after 1m0s
[15:58:45.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:26:0)
[15:58:45.068] Timer tick, asking Buildbucket for the build status
[15:58:45.247] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:45.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:27:0) after 1m0s
[15:59:45.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:27:0)
[15:59:45.306] Timer tick, asking Buildbucket for the build status
[15:59:45.458] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:45.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:28:0) after 1m0s
[16:00:45.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:28:0)
[16:00:45.597] Timer tick, asking Buildbucket for the build status
[16:00:45.836] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:45.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:29:0) after 1m0s
[16:01:45.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:29:0)
[16:01:45.924] Timer tick, asking Buildbucket for the build status
[16:01:46.874] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:46.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:30:0) after 1m0s
[16:02:47.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:30:0)
[16:02:47.067] Timer tick, asking Buildbucket for the build status
[16:02:47.294] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:47.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:31:0) after 1m0s
[16:03:47.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:31:0)
[16:03:47.501] Timer tick, asking Buildbucket for the build status
[16:03:48.391] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:48.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:32:0) after 1m0s
[16:04:48.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:32:0)
[16:04:48.421] Timer tick, asking Buildbucket for the build status
[16:04:50.494] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:50.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:33:0) after 1m0s
[16:05:50.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:33:0)
[16:05:50.710] Timer tick, asking Buildbucket for the build status
[16:05:51.197] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:51.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:34:0) after 1m0s
[16:06:51.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:34:0)
[16:06:51.298] Timer tick, asking Buildbucket for the build status
[16:06:51.747] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:51.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:35:0) after 1m0s
[16:07:51.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:35:0)
[16:07:51.740] Timer tick, asking Buildbucket for the build status
[16:07:51.950] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:51.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:36:0) after 1m0s
[16:08:51.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:36:0)
[16:08:51.983] Timer tick, asking Buildbucket for the build status
[16:08:52.366] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:52.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:37:0) after 1m0s
[16:09:52.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:37:0)
[16:09:52.510] Timer tick, asking Buildbucket for the build status
[16:09:52.678] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:52.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:38:0) after 1m0s
[16:10:52.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:38:0)
[16:10:52.719] Timer tick, asking Buildbucket for the build status
[16:10:53.094] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:53.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:39:0) after 1m0s
[16:11:53.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:39:0)
[16:11:53.127] Timer tick, asking Buildbucket for the build status
[16:11:53.300] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:53.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:40:0) after 1m0s
[16:12:53.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:40:0)
[16:12:53.375] Timer tick, asking Buildbucket for the build status
[16:12:53.569] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:53.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:41:0) after 1m0s
[16:13:53.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:41:0)
[16:13:53.589] Timer tick, asking Buildbucket for the build status
[16:13:53.730] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:53.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:42:0) after 1m0s
[16:14:53.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:42:0)
[16:14:53.826] Timer tick, asking Buildbucket for the build status
[16:14:54.032] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:54.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:43:0) after 1m0s
[16:15:54.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:43:0)
[16:15:54.084] Timer tick, asking Buildbucket for the build status
[16:15:54.437] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:54.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:44:0) after 1m0s
[16:16:54.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:44:0)
[16:16:54.521] Timer tick, asking Buildbucket for the build status
[16:16:55.515] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:55.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:45:0) after 1m0s
[16:17:55.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:45:0)
[16:17:55.536] Timer tick, asking Buildbucket for the build status
[16:17:56.240] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:56.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:46:0) after 1m0s
[16:18:56.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:46:0)
[16:18:56.367] Timer tick, asking Buildbucket for the build status
[16:18:56.526] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:56.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:47:0) after 1m0s
[16:19:56.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:47:0)
[16:19:56.595] Timer tick, asking Buildbucket for the build status
[16:19:57.854] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:57.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:48:0) after 1m0s
[16:20:57.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:48:0)
[16:20:57.888] Timer tick, asking Buildbucket for the build status
[16:20:58.666] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:58.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:49:0) after 1m0s
[16:21:58.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:49:0)
[16:21:58.698] Timer tick, asking Buildbucket for the build status
[16:21:58.933] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:58.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:50:0) after 1m0s
[16:22:58.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:50:0)
[16:22:58.993] Timer tick, asking Buildbucket for the build status
[16:23:00.089] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:00.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:51:0) after 1m0s
[16:24:00.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:51:0)
[16:24:00.114] Timer tick, asking Buildbucket for the build status
[16:24:00.256] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:00.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:52:0) after 1m0s
[16:25:00.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:52:0)
[16:25:00.286] Timer tick, asking Buildbucket for the build status
[16:25:00.429] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:00.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:53:0) after 1m0s
[16:26:00.490] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:53:0)
[16:26:00.490] Timer tick, asking Buildbucket for the build status
[16:26:01.473] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:01.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:54:0) after 1m0s
[16:27:01.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:54:0)
[16:27:01.546] Timer tick, asking Buildbucket for the build status
[16:27:04.158] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:04.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:55:0) after 1m0s
[16:28:04.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:55:0)
[16:28:04.526] Timer tick, asking Buildbucket for the build status
[16:28:04.828] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:04.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:56:0) after 1m0s
[16:29:05.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:56:0)
[16:29:05.064] Timer tick, asking Buildbucket for the build status
[16:29:05.275] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:05.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:57:0) after 1m0s
[16:30:05.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:57:0)
[16:30:05.361] Timer tick, asking Buildbucket for the build status
[16:30:05.534] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:05.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:58:0) after 1m0s
[16:31:05.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:58:0)
[16:31:05.613] Timer tick, asking Buildbucket for the build status
[16:31:06.034] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:06.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:59:0) after 1m0s
[16:32:06.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:59:0)
[16:32:06.108] Timer tick, asking Buildbucket for the build status
[16:32:06.309] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:06.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:60:0) after 1m0s
[16:33:06.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:60:0)
[16:33:06.556] Timer tick, asking Buildbucket for the build status
[16:33:07.068] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:07.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:61:0) after 1m0s
[16:34:07.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:61:0)
[16:34:07.134] Timer tick, asking Buildbucket for the build status
[16:34:07.391] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:07.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:62:0) after 1m0s
[16:35:07.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:62:0)
[16:35:07.417] Timer tick, asking Buildbucket for the build status
[16:35:10.451] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:10.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:63:0) after 1m0s
[16:36:10.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:63:0)
[16:36:10.500] Timer tick, asking Buildbucket for the build status
[16:36:10.746] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:10.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:64:0) after 1m0s
[16:37:10.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:64:0)
[16:37:10.849] Timer tick, asking Buildbucket for the build status
[16:37:11.134] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:11.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:65:0) after 1m0s
[16:38:11.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:65:0)
[16:38:11.305] Timer tick, asking Buildbucket for the build status
[16:38:15.711] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:15.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:66:0) after 1m0s
[16:39:15.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:66:0)
[16:39:15.857] Timer tick, asking Buildbucket for the build status
[16:39:16.487] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:67:0) after 1m0s
[16:40:16.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:67:0)
[16:40:16.537] Timer tick, asking Buildbucket for the build status
[16:40:17.865] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:17.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:68:0) after 1m0s
[16:41:18.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:68:0)
[16:41:18.006] Timer tick, asking Buildbucket for the build status
[16:41:18.617] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:18.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:69:0) after 1m0s
[16:42:18.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:69:0)
[16:42:18.679] Timer tick, asking Buildbucket for the build status
[16:42:19.651] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:19.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:70:0) after 1m0s
[16:43:19.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:70:0)
[16:43:19.702] Timer tick, asking Buildbucket for the build status
[16:43:19.934] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:19.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:71:0) after 1m0s
[16:44:20.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:71:0)
[16:44:20.055] Timer tick, asking Buildbucket for the build status
[16:44:20.317] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:20.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:72:0) after 1m0s
[16:45:20.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:72:0)
[16:45:20.349] Timer tick, asking Buildbucket for the build status
[16:45:20.629] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:20.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:73:0) after 1m0s
[16:46:20.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:73:0)
[16:46:20.709] Timer tick, asking Buildbucket for the build status
[16:46:20.869] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:20.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:74:0) after 1m0s
[16:47:20.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:74:0)
[16:47:20.956] Timer tick, asking Buildbucket for the build status
[16:47:21.113] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:21.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:75:0) after 1m0s
[16:48:21.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:75:0)
[16:48:21.154] Timer tick, asking Buildbucket for the build status
[16:48:21.383] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:21.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:76:0) after 1m0s
[16:49:21.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:76:0)
[16:49:21.437] Timer tick, asking Buildbucket for the build status
[16:49:22.062] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:22.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:77:0) after 1m0s
[16:50:22.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:77:0)
[16:50:22.094] Timer tick, asking Buildbucket for the build status
[16:50:23.658] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:23.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:78:0) after 1m0s
[16:51:23.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:78:0)
[16:51:23.668] Timer tick, asking Buildbucket for the build status
[16:51:24.208] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:24.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:79:0) after 1m0s
[16:52:24.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:79:0)
[16:52:24.355] Timer tick, asking Buildbucket for the build status
[16:52:24.526] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:24.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:80:0) after 1m0s
[16:53:24.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:80:0)
[16:53:24.550] Timer tick, asking Buildbucket for the build status
[16:53:25.339] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:25.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:81:0) after 1m0s
[16:54:25.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:81:0)
[16:54:25.488] Timer tick, asking Buildbucket for the build status
[16:54:25.658] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:25.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:82:0) after 1m0s
[16:55:25.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:82:0)
[16:55:25.701] Timer tick, asking Buildbucket for the build status
[16:55:26.035] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:26.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:83:0) after 1m0s
[16:56:26.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:83:0)
[16:56:26.167] Timer tick, asking Buildbucket for the build status
[16:56:26.330] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:26.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:84:0) after 1m0s
[16:57:26.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:84:0)
[16:57:26.405] Timer tick, asking Buildbucket for the build status
[16:57:26.632] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:85:0) after 1m0s
[16:58:26.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:85:0)
[16:58:26.657] Timer tick, asking Buildbucket for the build status
[16:58:26.831] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:26.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:86:0) after 1m0s
[16:59:26.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:86:0)
[16:59:26.859] Timer tick, asking Buildbucket for the build status
[16:59:27.062] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:27.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:87:0) after 1m0s
[17:00:27.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:87:0)
[17:00:27.086] Timer tick, asking Buildbucket for the build status
[17:00:27.927] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:27.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:88:0) after 1m0s
[17:01:27.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:88:0)
[17:01:27.918] Timer tick, asking Buildbucket for the build status
[17:01:28.365] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:28.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:89:0) after 1m0s
[17:02:28.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:89:0)
[17:02:28.441] Timer tick, asking Buildbucket for the build status
[17:02:28.605] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:90:0) after 1m0s
[17:03:28.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:90:0)
[17:03:28.640] Timer tick, asking Buildbucket for the build status
[17:03:29.445] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:29.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:91:0) after 1m0s
[17:04:29.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:91:0)
[17:04:29.529] Timer tick, asking Buildbucket for the build status
[17:04:29.988] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:29.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:92:0) after 1m0s
[17:05:30.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:92:0)
[17:05:30.067] Timer tick, asking Buildbucket for the build status
[17:05:30.256] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:30.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:93:0) after 1m0s
[17:06:30.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:93:0)
[17:06:30.334] Timer tick, asking Buildbucket for the build status
[17:06:30.719] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:30.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:94:0) after 1m0s
[17:07:30.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:94:0)
[17:07:30.833] Timer tick, asking Buildbucket for the build status
[17:07:31.195] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:31.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:95:0) after 1m0s
[17:08:31.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:95:0)
[17:08:31.239] Timer tick, asking Buildbucket for the build status
[17:08:31.532] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:31.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:96:0) after 1m0s
[17:09:31.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:96:0)
[17:09:31.664] Timer tick, asking Buildbucket for the build status
[17:09:31.831] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:31.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:97:0) after 1m0s
[17:10:31.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:97:0)
[17:10:31.940] Timer tick, asking Buildbucket for the build status
[17:10:32.081] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:32.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:98:0) after 1m0s
[17:11:32.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:98:0)
[17:11:32.129] Timer tick, asking Buildbucket for the build status
[17:11:32.299] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:32.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:99:0) after 1m0s
[17:12:32.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:99:0)
[17:12:32.344] Timer tick, asking Buildbucket for the build status
[17:12:32.945] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:32.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:100:0) after 1m0s
[17:13:33.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:100:0)
[17:13:33.016] Timer tick, asking Buildbucket for the build status
[17:13:33.288] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:33.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:101:0) after 1m0s
[17:14:33.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:101:0)
[17:14:33.356] Timer tick, asking Buildbucket for the build status
[17:14:33.609] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:33.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:102:0) after 1m0s
[17:15:33.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:102:0)
[17:15:33.671] Timer tick, asking Buildbucket for the build status
[17:15:33.869] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:33.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:103:0) after 1m0s
[17:16:33.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:103:0)
[17:16:33.942] Timer tick, asking Buildbucket for the build status
[17:16:34.834] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:104:0) after 1m0s
[17:17:34.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:104:0)
[17:17:34.888] Timer tick, asking Buildbucket for the build status
[17:17:35.280] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:35.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:105:0) after 1m0s
[17:18:35.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:105:0)
[17:18:35.314] Timer tick, asking Buildbucket for the build status
[17:18:35.713] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:35.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:106:0) after 1m0s
[17:19:35.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:106:0)
[17:19:35.724] Timer tick, asking Buildbucket for the build status
[17:19:36.795] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:36.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:107:0) after 1m0s
[17:20:37.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:107:0)
[17:20:37.392] Timer tick, asking Buildbucket for the build status
[17:20:38.466] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:38.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:108:0) after 1m0s
[17:21:39.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:108:0)
[17:21:39.029] Timer tick, asking Buildbucket for the build status
[17:21:39.227] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:39.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:109:0) after 1m0s
[17:22:39.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:109:0)
[17:22:39.907] Timer tick, asking Buildbucket for the build status
[17:22:40.612] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:40.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:110:0) after 1m0s
[17:23:40.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:110:0)
[17:23:40.886] Timer tick, asking Buildbucket for the build status
[17:23:41.194] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:41.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:111:0) after 1m0s
[17:24:41.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:111:0)
[17:24:41.630] Timer tick, asking Buildbucket for the build status
[17:24:41.839] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:41.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:112:0) after 1m0s
[17:25:42.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:112:0)
[17:25:42.247] Timer tick, asking Buildbucket for the build status
[17:25:43.127] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:43.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:113:0) after 1m0s
[17:26:43.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:113:0)
[17:26:43.325] Timer tick, asking Buildbucket for the build status
[17:26:44.353] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:44.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:114:0) after 1m0s
[17:27:44.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:114:0)
[17:27:44.545] Timer tick, asking Buildbucket for the build status
[17:27:44.769] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:44.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:115:0) after 1m0s
[17:28:45.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:115:0)
[17:28:45.039] Timer tick, asking Buildbucket for the build status
[17:28:45.440] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:45.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:116:0) after 1m0s
[17:29:45.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:116:0)
[17:29:45.482] Timer tick, asking Buildbucket for the build status
[17:29:45.651] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:45.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:117:0) after 1m0s
[17:30:45.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:117:0)
[17:30:45.835] Timer tick, asking Buildbucket for the build status
[17:30:46.383] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:46.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:118:0) after 1m0s
[17:31:46.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:118:0)
[17:31:46.498] Timer tick, asking Buildbucket for the build status
[17:31:47.153] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:47.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:119:0) after 1m0s
[17:32:47.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:119:0)
[17:32:47.240] Timer tick, asking Buildbucket for the build status
[17:32:47.398] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:47.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:120:0) after 1m0s
[17:33:47.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:120:0)
[17:33:47.815] Timer tick, asking Buildbucket for the build status
[17:33:47.986] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:47.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:121:0) after 1m0s
[17:34:48.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:121:0)
[17:34:48.013] Timer tick, asking Buildbucket for the build status
[17:34:49.343] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:49.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:122:0) after 1m0s
[17:35:49.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:122:0)
[17:35:49.520] Timer tick, asking Buildbucket for the build status
[17:35:49.717] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:49.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:123:0) after 1m0s
[17:36:50.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:123:0)
[17:36:50.102] Timer tick, asking Buildbucket for the build status
[17:36:50.264] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:50.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:124:0) after 1m0s
[17:37:50.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:124:0)
[17:37:50.602] Timer tick, asking Buildbucket for the build status
[17:37:50.972] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:50.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:125:0) after 1m0s
[17:38:51.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:125:0)
[17:38:51.349] Timer tick, asking Buildbucket for the build status
[17:38:51.502] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:51.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:126:0) after 1m0s
[17:39:52.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:126:0)
[17:39:52.078] Timer tick, asking Buildbucket for the build status
[17:39:52.385] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:52.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:127:0) after 1m0s
[17:40:52.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:127:0)
[17:40:52.508] Timer tick, asking Buildbucket for the build status
[17:40:52.959] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:52.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:128:0) after 1m0s
[17:41:53.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:128:0)
[17:41:53.329] Timer tick, asking Buildbucket for the build status
[17:41:53.483] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:53.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:129:0) after 1m0s
[17:42:53.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:129:0)
[17:42:53.712] Timer tick, asking Buildbucket for the build status
[17:42:53.884] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:53.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:130:0) after 1m0s
[17:43:53.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:130:0)
[17:43:53.965] Timer tick, asking Buildbucket for the build status
[17:43:54.391] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:54.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:131:0) after 1m0s
[17:44:54.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:131:0)
[17:44:54.439] Timer tick, asking Buildbucket for the build status
[17:44:55.349] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:55.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:132:0) after 1m0s
[17:45:55.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:132:0)
[17:45:55.381] Timer tick, asking Buildbucket for the build status
[17:45:55.523] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:133:0) after 1m0s
[17:46:55.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:133:0)
[17:46:55.822] Timer tick, asking Buildbucket for the build status
[17:46:56.422] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:56.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:134:0) after 1m0s
[17:47:56.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:134:0)
[17:47:56.606] Timer tick, asking Buildbucket for the build status
[17:47:56.919] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:56.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:135:0) after 1m0s
[17:48:57.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:135:0)
[17:48:57.124] Timer tick, asking Buildbucket for the build status
[17:48:57.524] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:57.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:136:0) after 1m0s
[17:49:57.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:136:0)
[17:49:57.620] Timer tick, asking Buildbucket for the build status
[17:49:58.023] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:58.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:137:0) after 1m0s
[17:50:58.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:137:0)
[17:50:58.150] Timer tick, asking Buildbucket for the build status
[17:50:58.342] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:58.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:138:0) after 1m0s
[17:51:58.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:138:0)
[17:51:58.464] Timer tick, asking Buildbucket for the build status
[17:51:58.684] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:139:0) after 1m0s
[17:52:58.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:139:0)
[17:52:58.715] Timer tick, asking Buildbucket for the build status
[17:52:59.162] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:59.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:140:0) after 1m0s
[17:53:59.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:140:0)
[17:53:59.218] Timer tick, asking Buildbucket for the build status
[17:53:59.826] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:59.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:141:0) after 1m0s
[17:54:59.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:141:0)
[17:54:59.857] Timer tick, asking Buildbucket for the build status
[17:54:59.993] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:59.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:142:0) after 1m0s
[17:56:00.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:142:0)
[17:56:00.197] Timer tick, asking Buildbucket for the build status
[17:56:00.392] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:00.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:143:0) after 1m0s
[17:57:00.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:143:0)
[17:57:00.478] Timer tick, asking Buildbucket for the build status
[17:57:01.684] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:01.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:144:0) after 1m0s
[17:58:01.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:144:0)
[17:58:01.723] Timer tick, asking Buildbucket for the build status
[17:58:01.842] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:01.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:145:0) after 1m0s
[17:59:02.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:145:0)
[17:59:02.014] Timer tick, asking Buildbucket for the build status
[17:59:02.451] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:02.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:146:0) after 1m0s
[18:00:02.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:146:0)
[18:00:02.717] Timer tick, asking Buildbucket for the build status
[18:00:02.916] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:02.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:147:0) after 1m0s
[18:01:03.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:147:0)
[18:01:03.014] Timer tick, asking Buildbucket for the build status
[18:01:03.258] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:03.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:148:0) after 1m0s
[18:02:03.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:148:0)
[18:02:03.285] Timer tick, asking Buildbucket for the build status
[18:02:03.512] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:03.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:149:0) after 1m0s
[18:03:03.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:149:0)
[18:03:03.552] Timer tick, asking Buildbucket for the build status
[18:03:03.783] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:03.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:150:0) after 1m0s
[18:04:03.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:150:0)
[18:04:03.868] Timer tick, asking Buildbucket for the build status
[18:04:04.721] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:04.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:151:0) after 1m0s
[18:05:05.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:151:0)
[18:05:05.164] Timer tick, asking Buildbucket for the build status
[18:05:05.764] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:05.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:152:0) after 1m0s
[18:06:07.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:152:0)
[18:06:07.163] Timer tick, asking Buildbucket for the build status
[18:06:07.743] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:153:0) after 1m0s
[18:07:07.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:153:0)
[18:07:07.793] Timer tick, asking Buildbucket for the build status
[18:07:08.135] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:08.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:154:0) after 1m0s
[18:08:08.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:154:0)
[18:08:08.328] Timer tick, asking Buildbucket for the build status
[18:08:09.027] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:09.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:155:0) after 1m0s
[18:09:09.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:155:0)
[18:09:09.056] Timer tick, asking Buildbucket for the build status
[18:09:09.763] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:09.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:156:0) after 1m0s
[18:10:09.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:156:0)
[18:10:09.788] Timer tick, asking Buildbucket for the build status
[18:10:10.048] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:10.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:157:0) after 1m0s
[18:11:10.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:157:0)
[18:11:10.195] Timer tick, asking Buildbucket for the build status
[18:11:10.372] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:10.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:158:0) after 1m0s
[18:12:10.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:158:0)
[18:12:10.512] Timer tick, asking Buildbucket for the build status
[18:12:11.286] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:11.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:159:0) after 1m0s
[18:13:11.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:159:0)
[18:13:11.369] Timer tick, asking Buildbucket for the build status
[18:13:12.027] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:12.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:160:0) after 1m0s
[18:14:12.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:160:0)
[18:14:12.081] Timer tick, asking Buildbucket for the build status
[18:14:12.483] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:12.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:161:0) after 1m0s
[18:15:12.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:161:0)
[18:15:12.540] Timer tick, asking Buildbucket for the build status
[18:15:12.907] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:12.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:162:0) after 1m0s
[18:16:12.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:162:0)
[18:16:12.938] Timer tick, asking Buildbucket for the build status
[18:16:13.502] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:13.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:163:0) after 1m0s
[18:17:13.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:163:0)
[18:17:13.549] Timer tick, asking Buildbucket for the build status
[18:17:13.770] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:13.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:164:0) after 1m0s
[18:18:13.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:164:0)
[18:18:13.906] Timer tick, asking Buildbucket for the build status
[18:18:14.101] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:14.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:165:0) after 1m0s
[18:19:14.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:165:0)
[18:19:14.211] Timer tick, asking Buildbucket for the build status
[18:19:14.394] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:14.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:166:0) after 1m0s
[18:20:14.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:166:0)
[18:20:14.418] Timer tick, asking Buildbucket for the build status
[18:20:15.861] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:15.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:167:0) after 1m0s
[18:21:15.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:167:0)
[18:21:15.981] Timer tick, asking Buildbucket for the build status
[18:21:16.136] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:168:0) after 1m0s
[18:22:16.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:168:0)
[18:22:16.221] Timer tick, asking Buildbucket for the build status
[18:22:16.613] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:16.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:169:0) after 1m0s
[18:23:16.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:169:0)
[18:23:16.643] Timer tick, asking Buildbucket for the build status
[18:23:16.811] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:16.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:170:0) after 1m0s
[18:24:17.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:170:0)
[18:24:17.093] Timer tick, asking Buildbucket for the build status
[18:24:18.125] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:18.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:171:0) after 1m0s
[18:25:18.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:171:0)
[18:25:18.183] Timer tick, asking Buildbucket for the build status
[18:25:18.347] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:18.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:172:0) after 1m0s
[18:26:18.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:172:0)
[18:26:18.396] Timer tick, asking Buildbucket for the build status
[18:26:18.836] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:18.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:173:0) after 1m0s
[18:27:18.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:173:0)
[18:27:18.891] Timer tick, asking Buildbucket for the build status
[18:27:19.714] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:19.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:174:0) after 1m0s
[18:28:19.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:174:0)
[18:28:19.829] Timer tick, asking Buildbucket for the build status
[18:28:20.043] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:20.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:175:0) after 1m0s
[18:29:20.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:175:0)
[18:29:20.089] Timer tick, asking Buildbucket for the build status
[18:29:21.769] Build 8907401621929586240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:21.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072831684007406416:176:0) after 1m0s
[18:29:44.891] Received PubSub notification, asking Buildbucket for the build status
[18:29:45.128] Build 8907401621929586240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:29:45.128] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563647383620781",
"created_by": "project:chromium",
"created_ts": "1563636869458102",
"id": "8907401621929586240",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b37e51fec0e18fd1b0c168d6823da200d96a4a7\"}}",
"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-so9v\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14187, \"got_angle_revision\": \"9ec3f51d11d92c8b87da27811cc7ab577705ea3c\", \"got_dawn_revision\": \"49aae0f3bde201d10f1b17d362b0d5b8f85dceb4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"5b37e51fec0e18fd1b0c168d6823da200d96a4a7\", \"got_revision_cp\": \"refs/heads/master@{#679390}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"6ee5e916e2850ae9ae916fdbf285893db6d437e0\", \"got_v8_revision_cp\": \"refs/heads/7.7.287@{#1}\", \"got_webrtc_revision\": \"1a49c1338830b222bc6b22b4e0690615bcd6fa52\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28604}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b37e51fec0e18fd1b0c168d6823da200d96a4a7\"}, \"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-so9v\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563636982001784",
"status": "COMPLETED",
"status_changed_ts": "1563647384156134",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14187",
"builder:Windows deterministic",
"buildset:commit/git/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b37e51fec0e18fd1b0c168d6823da200d96a4a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072831684007406416",
"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/8907401621929586240/+/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:4628d6b6cfc2f510",
"user_agent:luci-scheduler"
],
"updated_ts": "1563647384267860",
"url": "https://ci.chromium.org/b/8907401621929586240",
"utcnow_ts": "1563647385113385"
}
}
[18:29:45.128] Invocation finished in 2h55m17.035584644s with status SUCCEEDED