[00:04:20.890] New invocation is queued and will start shortly
[00:04:22.457] Starting the invocation (attempt 1)
[00:04:22.507] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:04:22.507] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:04:22.507] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069719308295749408",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ab94de1576b573b90e6caf1b9c59795c8bd18d95\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9069719308295749408",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"gitiles_ref:refs/heads/master"
]
}
[00:04:24.119] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566605062969784",
"id": "8904289245450293968",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ab94de1576b573b90e6caf1b9c59795c8bd18d95\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566605063618665",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14515",
"builder:Windows deterministic",
"buildset:commit/git/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069719308295749408",
"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/8904289245450293968/+/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": "1566605063618916",
"url": "https://ci.chromium.org/b/8904289245450293968",
"utcnow_ts": "1566605064090230"
}
}
[00:04:24.119] Task URL: https://ci.chromium.org/b/8904289245450293968
[00:04:24.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:2:0) after 1m0s
[00:05:24.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:2:0)
[00:05:24.219] Timer tick, asking Buildbucket for the build status
[00:05:24.556] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:24.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:3:0) after 1m0s
[00:06:24.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:3:0)
[00:06:24.600] Timer tick, asking Buildbucket for the build status
[00:06:24.998] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:24.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:4:0) after 1m0s
[00:07:25.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:4:0)
[00:07:25.024] Timer tick, asking Buildbucket for the build status
[00:07:28.211] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:28.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:5:0) after 1m0s
[00:08:28.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:5:0)
[00:08:28.309] Timer tick, asking Buildbucket for the build status
[00:08:30.063] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:30.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:6:0) after 1m0s
[00:09:30.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:6:0)
[00:09:30.054] Timer tick, asking Buildbucket for the build status
[00:09:33.071] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:33.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:7:0) after 1m0s
[00:10:33.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:7:0)
[00:10:33.138] Timer tick, asking Buildbucket for the build status
[00:10:33.801] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:33.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:8:0) after 1m0s
[00:11:33.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:8:0)
[00:11:33.881] Timer tick, asking Buildbucket for the build status
[00:11:34.641] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:34.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:9:0) after 1m0s
[00:12:34.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:9:0)
[00:12:34.753] Timer tick, asking Buildbucket for the build status
[00:12:36.197] Build 8904289245450293968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:36.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:10:0) after 1m0s
[00:12:38.540] Received PubSub notification, asking Buildbucket for the build status
[00:12:39.451] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:36.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:10:0)
[00:13:36.288] Timer tick, asking Buildbucket for the build status
[00:13:40.130] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:40.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:12:0) after 1m0s
[00:14:40.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:12:0)
[00:14:40.342] Timer tick, asking Buildbucket for the build status
[00:14:41.097] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:41.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:13:0) after 1m0s
[00:15:41.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:13:0)
[00:15:41.385] Timer tick, asking Buildbucket for the build status
[00:15:41.910] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:41.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:14:0) after 1m0s
[00:16:42.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:14:0)
[00:16:42.013] Timer tick, asking Buildbucket for the build status
[00:16:43.762] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:43.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:15:0) after 1m0s
[00:17:43.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:15:0)
[00:17:43.952] Timer tick, asking Buildbucket for the build status
[00:17:44.195] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:44.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:16:0) after 1m0s
[00:18:44.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:16:0)
[00:18:44.220] Timer tick, asking Buildbucket for the build status
[00:18:44.742] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:44.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:17:0) after 1m0s
[00:19:44.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:17:0)
[00:19:44.732] Timer tick, asking Buildbucket for the build status
[00:19:45.740] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:45.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:18:0) after 1m0s
[00:20:45.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:18:0)
[00:20:45.821] Timer tick, asking Buildbucket for the build status
[00:20:48.624] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:48.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:19:0) after 1m0s
[00:21:48.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:19:0)
[00:21:48.749] Timer tick, asking Buildbucket for the build status
[00:21:49.556] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:49.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:20:0) after 1m0s
[00:22:49.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:20:0)
[00:22:49.585] Timer tick, asking Buildbucket for the build status
[00:22:50.835] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:50.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:21:0) after 1m0s
[00:23:50.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:21:0)
[00:23:50.899] Timer tick, asking Buildbucket for the build status
[00:23:51.100] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:51.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:22:0) after 1m0s
[00:24:51.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:22:0)
[00:24:51.204] Timer tick, asking Buildbucket for the build status
[00:24:51.701] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:51.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:23:0) after 1m0s
[00:25:51.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:23:0)
[00:25:51.724] Timer tick, asking Buildbucket for the build status
[00:25:51.922] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:51.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:24:0) after 1m0s
[00:26:51.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:24:0)
[00:26:51.931] Timer tick, asking Buildbucket for the build status
[00:26:52.362] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:52.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:25:0) after 1m0s
[00:27:52.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:25:0)
[00:27:52.461] Timer tick, asking Buildbucket for the build status
[00:27:53.047] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:26:0) after 1m0s
[00:28:53.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:26:0)
[00:28:53.096] Timer tick, asking Buildbucket for the build status
[00:28:53.865] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:53.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:27:0) after 1m0s
[00:29:53.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:27:0)
[00:29:53.902] Timer tick, asking Buildbucket for the build status
[00:29:54.217] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:54.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:28:0) after 1m0s
[00:30:54.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:28:0)
[00:30:54.283] Timer tick, asking Buildbucket for the build status
[00:30:55.683] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:55.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:29:0) after 1m0s
[00:31:55.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:29:0)
[00:31:55.707] Timer tick, asking Buildbucket for the build status
[00:31:55.902] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:55.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:30:0) after 1m0s
[00:32:55.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:30:0)
[00:32:55.962] Timer tick, asking Buildbucket for the build status
[00:32:56.421] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:56.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:31:0) after 1m0s
[00:33:56.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:31:0)
[00:33:56.457] Timer tick, asking Buildbucket for the build status
[00:33:56.669] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:32:0) after 1m0s
[00:34:56.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:32:0)
[00:34:56.668] Timer tick, asking Buildbucket for the build status
[00:34:57.803] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:57.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:33:0) after 1m0s
[00:35:57.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:33:0)
[00:35:57.973] Timer tick, asking Buildbucket for the build status
[00:35:58.532] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:58.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:34:0) after 1m0s
[00:36:58.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:34:0)
[00:36:58.539] Timer tick, asking Buildbucket for the build status
[00:37:00.915] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:00.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:35:0) after 1m0s
[00:38:01.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:35:0)
[00:38:01.311] Timer tick, asking Buildbucket for the build status
[00:38:03.306] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:03.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:36:0) after 1m0s
[00:39:03.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:36:0)
[00:39:03.618] Timer tick, asking Buildbucket for the build status
[00:39:06.466] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:06.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:37:0) after 1m0s
[00:40:06.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:37:0)
[00:40:06.493] Timer tick, asking Buildbucket for the build status
[00:40:06.786] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:38:0) after 1m0s
[00:41:06.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:38:0)
[00:41:06.811] Timer tick, asking Buildbucket for the build status
[00:41:06.983] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:06.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:39:0) after 1m0s
[00:42:07.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:39:0)
[00:42:07.042] Timer tick, asking Buildbucket for the build status
[00:42:07.231] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:07.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:40:0) after 1m0s
[00:43:07.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:40:0)
[00:43:07.282] Timer tick, asking Buildbucket for the build status
[00:43:07.631] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:07.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:41:0) after 1m0s
[00:44:07.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:41:0)
[00:44:07.660] Timer tick, asking Buildbucket for the build status
[00:44:08.243] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:08.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:42:0) after 1m0s
[00:45:08.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:42:0)
[00:45:08.283] Timer tick, asking Buildbucket for the build status
[00:45:08.842] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:08.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:43:0) after 1m0s
[00:46:08.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:43:0)
[00:46:08.907] Timer tick, asking Buildbucket for the build status
[00:46:09.699] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:09.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:44:0) after 1m0s
[00:47:09.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:44:0)
[00:47:09.781] Timer tick, asking Buildbucket for the build status
[00:47:10.212] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:10.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:45:0) after 1m0s
[00:48:10.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:45:0)
[00:48:10.257] Timer tick, asking Buildbucket for the build status
[00:48:10.675] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:46:0) after 1m0s
[00:49:10.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:46:0)
[00:49:10.734] Timer tick, asking Buildbucket for the build status
[00:49:11.416] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:11.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:47:0) after 1m0s
[00:50:11.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:47:0)
[00:50:11.494] Timer tick, asking Buildbucket for the build status
[00:50:11.623] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:11.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:48:0) after 1m0s
[00:51:11.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:48:0)
[00:51:11.652] Timer tick, asking Buildbucket for the build status
[00:51:12.161] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:12.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:49:0) after 1m0s
[00:52:12.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:49:0)
[00:52:12.179] Timer tick, asking Buildbucket for the build status
[00:52:13.029] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:13.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:50:0) after 1m0s
[00:53:13.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:50:0)
[00:53:13.069] Timer tick, asking Buildbucket for the build status
[00:53:13.353] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:13.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:51:0) after 1m0s
[00:54:13.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:51:0)
[00:54:13.448] Timer tick, asking Buildbucket for the build status
[00:54:13.737] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:13.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:52:0) after 1m0s
[00:55:13.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:52:0)
[00:55:13.796] Timer tick, asking Buildbucket for the build status
[00:55:14.164] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:14.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:53:0) after 1m0s
[00:56:14.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:53:0)
[00:56:14.186] Timer tick, asking Buildbucket for the build status
[00:56:16.046] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:16.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:54:0) after 1m0s
[00:57:16.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:54:0)
[00:57:16.122] Timer tick, asking Buildbucket for the build status
[00:57:19.625] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:19.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:55:0) after 1m0s
[00:58:19.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:55:0)
[00:58:19.698] Timer tick, asking Buildbucket for the build status
[00:58:20.367] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:20.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:56:0) after 1m0s
[00:59:20.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:56:0)
[00:59:20.409] Timer tick, asking Buildbucket for the build status
[00:59:21.036] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:21.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:57:0) after 1m0s
[01:00:21.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:57:0)
[01:00:21.070] Timer tick, asking Buildbucket for the build status
[01:00:21.357] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:21.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:58:0) after 1m0s
[01:01:21.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:58:0)
[01:01:21.357] Timer tick, asking Buildbucket for the build status
[01:01:21.772] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:21.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:59:0) after 1m0s
[01:02:21.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:59:0)
[01:02:21.820] Timer tick, asking Buildbucket for the build status
[01:02:26.548] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:26.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:60:0) after 1m0s
[01:03:26.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:60:0)
[01:03:26.659] Timer tick, asking Buildbucket for the build status
[01:03:26.981] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:26.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:61:0) after 1m0s
[01:04:27.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:61:0)
[01:04:27.013] Timer tick, asking Buildbucket for the build status
[01:04:27.197] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:27.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:62:0) after 1m0s
[01:05:27.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:62:0)
[01:05:27.200] Timer tick, asking Buildbucket for the build status
[01:05:27.491] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:27.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:63:0) after 1m0s
[01:06:27.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:63:0)
[01:06:27.523] Timer tick, asking Buildbucket for the build status
[01:06:27.976] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:27.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:64:0) after 1m0s
[01:07:28.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:64:0)
[01:07:28.098] Timer tick, asking Buildbucket for the build status
[01:07:28.528] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:28.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:65:0) after 1m0s
[01:08:28.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:65:0)
[01:08:28.566] Timer tick, asking Buildbucket for the build status
[01:08:29.174] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:29.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:66:0) after 1m0s
[01:09:29.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:66:0)
[01:09:29.327] Timer tick, asking Buildbucket for the build status
[01:09:29.564] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:29.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:67:0) after 1m0s
[01:10:29.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:67:0)
[01:10:29.595] Timer tick, asking Buildbucket for the build status
[01:10:30.281] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:30.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:68:0) after 1m0s
[01:11:30.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:68:0)
[01:11:30.296] Timer tick, asking Buildbucket for the build status
[01:11:30.801] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:69:0) after 1m0s
[01:12:30.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:69:0)
[01:12:30.831] Timer tick, asking Buildbucket for the build status
[01:12:33.406] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:33.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:70:0) after 1m0s
[01:13:33.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:70:0)
[01:13:33.390] Timer tick, asking Buildbucket for the build status
[01:13:33.925] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:33.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:71:0) after 1m0s
[01:14:33.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:71:0)
[01:14:33.964] Timer tick, asking Buildbucket for the build status
[01:14:34.348] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:72:0) after 1m0s
[01:15:34.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:72:0)
[01:15:34.417] Timer tick, asking Buildbucket for the build status
[01:15:34.788] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:34.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:73:0) after 1m0s
[01:16:34.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:73:0)
[01:16:34.819] Timer tick, asking Buildbucket for the build status
[01:16:35.258] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:35.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:74:0) after 1m0s
[01:17:35.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:74:0)
[01:17:35.318] Timer tick, asking Buildbucket for the build status
[01:17:36.461] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:36.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:75:0) after 1m0s
[01:18:36.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:75:0)
[01:18:36.525] Timer tick, asking Buildbucket for the build status
[01:18:37.514] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:37.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:76:0) after 1m0s
[01:19:37.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:76:0)
[01:19:37.518] Timer tick, asking Buildbucket for the build status
[01:19:38.404] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:38.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:77:0) after 1m0s
[01:20:38.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:77:0)
[01:20:38.496] Timer tick, asking Buildbucket for the build status
[01:20:39.317] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:39.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:78:0) after 1m0s
[01:21:39.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:78:0)
[01:21:39.394] Timer tick, asking Buildbucket for the build status
[01:21:41.786] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:41.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:79:0) after 1m0s
[01:22:41.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:79:0)
[01:22:41.857] Timer tick, asking Buildbucket for the build status
[01:22:42.227] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:42.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:80:0) after 1m0s
[01:23:42.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:80:0)
[01:23:42.263] Timer tick, asking Buildbucket for the build status
[01:23:43.078] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:43.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:81:0) after 1m0s
[01:24:43.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:81:0)
[01:24:43.120] Timer tick, asking Buildbucket for the build status
[01:24:45.394] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:45.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:82:0) after 1m0s
[01:25:45.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:82:0)
[01:25:45.421] Timer tick, asking Buildbucket for the build status
[01:25:45.911] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:45.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:83:0) after 1m0s
[01:26:45.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:83:0)
[01:26:45.941] Timer tick, asking Buildbucket for the build status
[01:26:47.087] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:47.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:84:0) after 1m0s
[01:27:47.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:84:0)
[01:27:47.211] Timer tick, asking Buildbucket for the build status
[01:27:47.775] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:47.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:85:0) after 1m0s
[01:28:47.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:85:0)
[01:28:47.880] Timer tick, asking Buildbucket for the build status
[01:28:48.788] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:48.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:86:0) after 1m0s
[01:29:48.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:86:0)
[01:29:48.812] Timer tick, asking Buildbucket for the build status
[01:29:49.332] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:49.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:87:0) after 1m0s
[01:30:49.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:87:0)
[01:30:49.392] Timer tick, asking Buildbucket for the build status
[01:30:49.908] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:49.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:88:0) after 1m0s
[01:31:49.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:88:0)
[01:31:49.913] Timer tick, asking Buildbucket for the build status
[01:31:51.262] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:51.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:89:0) after 1m0s
[01:32:51.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:89:0)
[01:32:51.327] Timer tick, asking Buildbucket for the build status
[01:32:52.225] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:52.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:90:0) after 1m0s
[01:33:52.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:90:0)
[01:33:52.283] Timer tick, asking Buildbucket for the build status
[01:33:53.317] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:53.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:91:0) after 1m0s
[01:34:53.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:91:0)
[01:34:53.412] Timer tick, asking Buildbucket for the build status
[01:34:55.786] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:92:0) after 1m0s
[01:35:55.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:92:0)
[01:35:55.888] Timer tick, asking Buildbucket for the build status
[01:35:56.908] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:56.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:93:0) after 1m0s
[01:36:56.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:93:0)
[01:36:56.947] Timer tick, asking Buildbucket for the build status
[01:37:00.059] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:00.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:94:0) after 1m0s
[01:38:00.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:94:0)
[01:38:00.087] Timer tick, asking Buildbucket for the build status
[01:38:02.870] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:02.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:95:0) after 1m0s
[01:39:02.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:95:0)
[01:39:02.898] Timer tick, asking Buildbucket for the build status
[01:39:03.213] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:03.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:96:0) after 1m0s
[01:40:03.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:96:0)
[01:40:03.207] Timer tick, asking Buildbucket for the build status
[01:40:04.793] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:97:0) after 1m0s
[01:41:04.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:97:0)
[01:41:04.855] Timer tick, asking Buildbucket for the build status
[01:41:05.493] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:05.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:98:0) after 1m0s
[01:42:05.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:98:0)
[01:42:05.570] Timer tick, asking Buildbucket for the build status
[01:42:08.866] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:08.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:99:0) after 1m0s
[01:43:08.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:99:0)
[01:43:08.894] Timer tick, asking Buildbucket for the build status
[01:43:12.431] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:12.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:100:0) after 1m0s
[01:44:12.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:100:0)
[01:44:12.536] Timer tick, asking Buildbucket for the build status
[01:44:13.054] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:13.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:101:0) after 1m0s
[01:45:13.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:101:0)
[01:45:13.237] Timer tick, asking Buildbucket for the build status
[01:45:14.058] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:14.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:102:0) after 1m0s
[01:46:14.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:102:0)
[01:46:14.099] Timer tick, asking Buildbucket for the build status
[01:46:14.543] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:103:0) after 1m0s
[01:47:14.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:103:0)
[01:47:14.598] Timer tick, asking Buildbucket for the build status
[01:47:16.532] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:16.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:104:0) after 1m0s
[01:48:16.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:104:0)
[01:48:16.630] Timer tick, asking Buildbucket for the build status
[01:48:16.915] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:16.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:105:0) after 1m0s
[01:49:16.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:105:0)
[01:49:16.983] Timer tick, asking Buildbucket for the build status
[01:49:21.993] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:21.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:106:0) after 1m0s
[01:50:22.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:106:0)
[01:50:22.056] Timer tick, asking Buildbucket for the build status
[01:50:22.379] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:22.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:107:0) after 1m0s
[01:51:22.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:107:0)
[01:51:22.507] Timer tick, asking Buildbucket for the build status
[01:51:22.826] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:22.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:108:0) after 1m0s
[01:52:22.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:108:0)
[01:52:22.806] Timer tick, asking Buildbucket for the build status
[01:52:27.824] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:109:0) after 1m0s
[01:53:27.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:109:0)
[01:53:27.854] Timer tick, asking Buildbucket for the build status
[01:53:28.098] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:28.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:110:0) after 1m0s
[01:54:28.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:110:0)
[01:54:28.184] Timer tick, asking Buildbucket for the build status
[01:54:28.453] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:28.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:111:0) after 1m0s
[01:55:28.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:111:0)
[01:55:28.538] Timer tick, asking Buildbucket for the build status
[01:55:29.426] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:29.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:112:0) after 1m0s
[01:56:29.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:112:0)
[01:56:29.470] Timer tick, asking Buildbucket for the build status
[01:56:29.829] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:29.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:113:0) after 1m0s
[01:57:29.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:113:0)
[01:57:29.866] Timer tick, asking Buildbucket for the build status
[01:57:33.125] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:33.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:114:0) after 1m0s
[01:58:33.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:114:0)
[01:58:33.269] Timer tick, asking Buildbucket for the build status
[01:58:33.705] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:33.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:115:0) after 1m0s
[01:59:33.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:115:0)
[01:59:33.748] Timer tick, asking Buildbucket for the build status
[01:59:34.170] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:34.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:116:0) after 1m0s
[02:00:34.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:116:0)
[02:00:34.240] Timer tick, asking Buildbucket for the build status
[02:00:35.219] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:35.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:117:0) after 1m0s
[02:01:35.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:117:0)
[02:01:35.275] Timer tick, asking Buildbucket for the build status
[02:01:36.325] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:36.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:118:0) after 1m0s
[02:02:36.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:118:0)
[02:02:36.390] Timer tick, asking Buildbucket for the build status
[02:02:36.886] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:36.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:119:0) after 1m0s
[02:03:36.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:119:0)
[02:03:36.922] Timer tick, asking Buildbucket for the build status
[02:03:37.206] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:37.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:120:0) after 1m0s
[02:04:37.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:120:0)
[02:04:37.304] Timer tick, asking Buildbucket for the build status
[02:04:37.738] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:37.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:121:0) after 1m0s
[02:05:37.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:121:0)
[02:05:37.773] Timer tick, asking Buildbucket for the build status
[02:05:39.472] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:39.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:122:0) after 1m0s
[02:06:39.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:122:0)
[02:06:39.505] Timer tick, asking Buildbucket for the build status
[02:06:39.685] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:39.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:123:0) after 1m0s
[02:07:39.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:123:0)
[02:07:39.755] Timer tick, asking Buildbucket for the build status
[02:07:40.458] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:40.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:124:0) after 1m0s
[02:08:40.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:124:0)
[02:08:40.461] Timer tick, asking Buildbucket for the build status
[02:08:40.733] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:40.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:125:0) after 1m0s
[02:09:40.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:125:0)
[02:09:40.803] Timer tick, asking Buildbucket for the build status
[02:09:40.979] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:40.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:126:0) after 1m0s
[02:10:41.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:126:0)
[02:10:41.083] Timer tick, asking Buildbucket for the build status
[02:10:41.352] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:41.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:127:0) after 1m0s
[02:11:41.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:127:0)
[02:11:41.507] Timer tick, asking Buildbucket for the build status
[02:11:41.909] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:41.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:128:0) after 1m0s
[02:12:41.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:128:0)
[02:12:41.965] Timer tick, asking Buildbucket for the build status
[02:12:43.465] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:43.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:129:0) after 1m0s
[02:13:43.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:129:0)
[02:13:43.469] Timer tick, asking Buildbucket for the build status
[02:13:45.575] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:45.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:130:0) after 1m0s
[02:14:45.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:130:0)
[02:14:45.694] Timer tick, asking Buildbucket for the build status
[02:14:46.229] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:46.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:131:0) after 1m0s
[02:15:46.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:131:0)
[02:15:46.306] Timer tick, asking Buildbucket for the build status
[02:15:47.490] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:47.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:132:0) after 1m0s
[02:16:47.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:132:0)
[02:16:47.617] Timer tick, asking Buildbucket for the build status
[02:16:48.010] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:48.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:133:0) after 1m0s
[02:17:48.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:133:0)
[02:17:48.146] Timer tick, asking Buildbucket for the build status
[02:17:48.370] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:134:0) after 1m0s
[02:18:48.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:134:0)
[02:18:48.445] Timer tick, asking Buildbucket for the build status
[02:18:49.335] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:49.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:135:0) after 1m0s
[02:19:49.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:135:0)
[02:19:49.396] Timer tick, asking Buildbucket for the build status
[02:19:49.588] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:49.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:136:0) after 1m0s
[02:20:49.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:136:0)
[02:20:49.782] Timer tick, asking Buildbucket for the build status
[02:20:49.974] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:49.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:137:0) after 1m0s
[02:21:50.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:137:0)
[02:21:50.041] Timer tick, asking Buildbucket for the build status
[02:21:50.335] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:50.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:138:0) after 1m0s
[02:22:50.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:138:0)
[02:22:50.455] Timer tick, asking Buildbucket for the build status
[02:22:50.634] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:50.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:139:0) after 1m0s
[02:23:50.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:139:0)
[02:23:50.809] Timer tick, asking Buildbucket for the build status
[02:23:51.247] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:51.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:140:0) after 1m0s
[02:24:51.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:140:0)
[02:24:51.423] Timer tick, asking Buildbucket for the build status
[02:24:51.610] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:51.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:141:0) after 1m0s
[02:25:51.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:141:0)
[02:25:51.766] Timer tick, asking Buildbucket for the build status
[02:25:52.402] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:52.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:142:0) after 1m0s
[02:26:52.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:142:0)
[02:26:52.553] Timer tick, asking Buildbucket for the build status
[02:26:52.780] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:52.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:143:0) after 1m0s
[02:27:52.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:143:0)
[02:27:52.949] Timer tick, asking Buildbucket for the build status
[02:27:53.123] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:53.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:144:0) after 1m0s
[02:28:53.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:144:0)
[02:28:53.151] Timer tick, asking Buildbucket for the build status
[02:28:54.253] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:145:0) after 1m0s
[02:29:54.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:145:0)
[02:29:54.402] Timer tick, asking Buildbucket for the build status
[02:29:57.999] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:57.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:146:0) after 1m0s
[02:30:58.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:146:0)
[02:30:58.028] Timer tick, asking Buildbucket for the build status
[02:30:58.366] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:58.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:147:0) after 1m0s
[02:31:58.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:147:0)
[02:31:58.456] Timer tick, asking Buildbucket for the build status
[02:31:59.903] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:59.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:148:0) after 1m0s
[02:33:00.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:148:0)
[02:33:00.048] Timer tick, asking Buildbucket for the build status
[02:33:00.346] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:00.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:149:0) after 1m0s
[02:34:00.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:149:0)
[02:34:00.717] Timer tick, asking Buildbucket for the build status
[02:34:00.870] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:00.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:150:0) after 1m0s
[02:35:00.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:150:0)
[02:35:00.949] Timer tick, asking Buildbucket for the build status
[02:35:01.160] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:01.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:151:0) after 1m0s
[02:36:01.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:151:0)
[02:36:01.254] Timer tick, asking Buildbucket for the build status
[02:36:03.153] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:03.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:152:0) after 1m0s
[02:37:03.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:152:0)
[02:37:03.526] Timer tick, asking Buildbucket for the build status
[02:37:03.728] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:03.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:153:0) after 1m0s
[02:38:03.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:153:0)
[02:38:03.851] Timer tick, asking Buildbucket for the build status
[02:38:04.399] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:04.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:154:0) after 1m0s
[02:39:04.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:154:0)
[02:39:04.597] Timer tick, asking Buildbucket for the build status
[02:39:04.955] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:04.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:155:0) after 1m0s
[02:40:05.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:155:0)
[02:40:05.034] Timer tick, asking Buildbucket for the build status
[02:40:05.854] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:05.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:156:0) after 1m0s
[02:41:05.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:156:0)
[02:41:05.928] Timer tick, asking Buildbucket for the build status
[02:41:08.438] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:08.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:157:0) after 1m0s
[02:42:08.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:157:0)
[02:42:08.593] Timer tick, asking Buildbucket for the build status
[02:42:09.270] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:09.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:158:0) after 1m0s
[02:43:09.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:158:0)
[02:43:09.494] Timer tick, asking Buildbucket for the build status
[02:43:09.795] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:09.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:159:0) after 1m0s
[02:44:09.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:159:0)
[02:44:09.847] Timer tick, asking Buildbucket for the build status
[02:44:10.117] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:10.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:160:0) after 1m0s
[02:45:10.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:160:0)
[02:45:10.220] Timer tick, asking Buildbucket for the build status
[02:45:12.119] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:161:0) after 1m0s
[02:46:12.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:161:0)
[02:46:12.193] Timer tick, asking Buildbucket for the build status
[02:46:12.517] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:12.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:162:0) after 1m0s
[02:47:12.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:162:0)
[02:47:12.593] Timer tick, asking Buildbucket for the build status
[02:47:13.547] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:163:0) after 1m0s
[02:48:13.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:163:0)
[02:48:13.527] Timer tick, asking Buildbucket for the build status
[02:48:14.174] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:14.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:164:0) after 1m0s
[02:49:14.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:164:0)
[02:49:14.259] Timer tick, asking Buildbucket for the build status
[02:49:15.826] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:15.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:165:0) after 1m0s
[02:50:15.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:165:0)
[02:50:15.963] Timer tick, asking Buildbucket for the build status
[02:50:16.483] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:16.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:166:0) after 1m0s
[02:51:16.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:166:0)
[02:51:16.698] Timer tick, asking Buildbucket for the build status
[02:51:16.932] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:167:0) after 1m0s
[02:52:17.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:167:0)
[02:52:17.061] Timer tick, asking Buildbucket for the build status
[02:52:17.570] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:17.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:168:0) after 1m0s
[02:53:17.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:168:0)
[02:53:17.707] Timer tick, asking Buildbucket for the build status
[02:53:17.889] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:17.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:169:0) after 1m0s
[02:54:17.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:169:0)
[02:54:17.923] Timer tick, asking Buildbucket for the build status
[02:54:18.641] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:18.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:170:0) after 1m0s
[02:55:18.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:170:0)
[02:55:18.841] Timer tick, asking Buildbucket for the build status
[02:55:21.376] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:21.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:171:0) after 1m0s
[02:56:21.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:171:0)
[02:56:21.455] Timer tick, asking Buildbucket for the build status
[02:56:22.387] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:22.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:172:0) after 1m0s
[02:57:22.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:172:0)
[02:57:22.449] Timer tick, asking Buildbucket for the build status
[02:57:23.124] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:23.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:173:0) after 1m0s
[02:58:23.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:173:0)
[02:58:23.293] Timer tick, asking Buildbucket for the build status
[02:58:23.802] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:23.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:174:0) after 1m0s
[02:59:23.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:174:0)
[02:59:23.915] Timer tick, asking Buildbucket for the build status
[02:59:24.207] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:24.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:175:0) after 1m0s
[03:00:24.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:175:0)
[03:00:24.298] Timer tick, asking Buildbucket for the build status
[03:00:24.699] Build 8904289245450293968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:24.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069719308295749408:176:0) after 1m0s
[03:00:37.413] Received PubSub notification, asking Buildbucket for the build status
[03:00:37.887] Build 8904289245450293968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:00:37.887] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566615636059876",
"created_by": "project:chromium",
"created_ts": "1566605062969784",
"id": "8904289245450293968",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ab94de1576b573b90e6caf1b9c59795c8bd18d95\"}}",
"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-bzrg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14515, \"got_angle_revision\": \"2f4a751866bc19ffc9f19514c00246cdfea073ff\", \"got_dawn_revision\": \"3f21e11e240ae44f1b49606d42b062eaf208a5e4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"ab94de1576b573b90e6caf1b9c59795c8bd18d95\", \"got_revision_cp\": \"refs/heads/master@{#690128}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9551b47052296a86b3100669c7dd673173bee0e0\", \"got_v8_revision_cp\": \"refs/heads/7.8.187@{#1}\", \"got_webrtc_revision\": \"a2dae38ee7729ec1d6fcb7d22b7a597c627ad81a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28937}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ab94de1576b573b90e6caf1b9c59795c8bd18d95\"}, \"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-bzrg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566605553611030",
"status": "COMPLETED",
"status_changed_ts": "1566615636477051",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14515",
"builder:Windows deterministic",
"buildset:commit/git/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ab94de1576b573b90e6caf1b9c59795c8bd18d95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069719308295749408",
"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/8904289245450293968/+/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:46d9c1c05cc9fd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1566615636481995",
"url": "https://ci.chromium.org/b/8904289245450293968",
"utcnow_ts": "1566615637878272"
}
}
[03:00:37.887] Invocation finished in 2h56m17.014726041s with status SUCCEEDED