[13:44:40.642] New invocation is queued and will start shortly
[13:44:42.231] Starting the invocation (attempt 1)
[13:44:42.293] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:44:42.299] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:44:42.299] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9046293680314420384",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8db5101c01b1390825e1e42e6085ea6d92d15ed9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9046293680314420384",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"gitiles_ref:refs/heads/master"
]
}
[13:44:43.161] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1588945482427830",
"id": "8880863617776456672",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8db5101c01b1390825e1e42e6085ea6d92d15ed9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1588945482953933",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16445",
"builder:Windows deterministic",
"buildset:commit/git/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046293680314420384",
"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/8880863617776456672/+/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": "1588945482954078",
"url": "https://ci.chromium.org/b/8880863617776456672",
"utcnow_ts": "1588945483151154"
}
}
[13:44:43.161] Task URL: https://ci.chromium.org/b/8880863617776456672
[13:44:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:2:0) after 1m0s
[13:44:46.323] Received PubSub notification, asking Buildbucket for the build status
[13:44:46.412] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:2:0)
[13:45:43.236] Timer tick, asking Buildbucket for the build status
[13:45:43.587] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:4:0) after 1m0s
[13:46:43.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:4:0)
[13:46:43.656] Timer tick, asking Buildbucket for the build status
[13:46:43.950] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:43.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:5:0) after 1m0s
[13:47:44.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:5:0)
[13:47:44.025] Timer tick, asking Buildbucket for the build status
[13:47:44.330] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:44.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:6:0) after 1m0s
[13:48:44.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:6:0)
[13:48:44.329] Timer tick, asking Buildbucket for the build status
[13:48:44.736] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:44.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:7:0) after 1m0s
[13:49:44.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:7:0)
[13:49:44.842] Timer tick, asking Buildbucket for the build status
[13:49:45.019] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:45.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:8:0) after 1m0s
[13:50:45.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:8:0)
[13:50:45.044] Timer tick, asking Buildbucket for the build status
[13:50:45.311] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:45.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:9:0) after 1m0s
[13:51:45.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:9:0)
[13:51:45.350] Timer tick, asking Buildbucket for the build status
[13:51:45.573] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:45.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:10:0) after 1m0s
[13:52:45.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:10:0)
[13:52:45.750] Timer tick, asking Buildbucket for the build status
[13:52:45.876] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:45.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:11:0) after 1m0s
[13:53:45.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:11:0)
[13:53:45.899] Timer tick, asking Buildbucket for the build status
[13:53:46.127] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:46.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:12:0) after 1m0s
[13:54:46.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:12:0)
[13:54:46.145] Timer tick, asking Buildbucket for the build status
[13:54:46.313] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:46.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:13:0) after 1m0s
[13:55:46.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:13:0)
[13:55:46.334] Timer tick, asking Buildbucket for the build status
[13:55:46.555] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:14:0) after 1m0s
[13:56:46.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:14:0)
[13:56:46.599] Timer tick, asking Buildbucket for the build status
[13:56:46.741] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:15:0) after 1m0s
[13:57:46.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:15:0)
[13:57:46.890] Timer tick, asking Buildbucket for the build status
[13:57:47.238] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:47.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:16:0) after 1m0s
[13:58:47.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:16:0)
[13:58:47.468] Timer tick, asking Buildbucket for the build status
[13:58:47.595] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:17:0) after 1m0s
[13:59:47.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:17:0)
[13:59:47.722] Timer tick, asking Buildbucket for the build status
[13:59:47.951] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:18:0) after 1m0s
[14:00:48.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:18:0)
[14:00:48.022] Timer tick, asking Buildbucket for the build status
[14:00:48.163] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:48.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:19:0) after 1m0s
[14:01:48.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:19:0)
[14:01:48.274] Timer tick, asking Buildbucket for the build status
[14:01:48.865] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:48.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:20:0) after 1m0s
[14:02:48.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:20:0)
[14:02:48.922] Timer tick, asking Buildbucket for the build status
[14:02:49.066] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:49.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:21:0) after 1m0s
[14:03:49.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:21:0)
[14:03:49.133] Timer tick, asking Buildbucket for the build status
[14:03:49.288] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:49.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:22:0) after 1m0s
[14:04:49.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:22:0)
[14:04:49.328] Timer tick, asking Buildbucket for the build status
[14:04:49.583] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:49.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:23:0) after 1m0s
[14:05:50.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:23:0)
[14:05:50.182] Timer tick, asking Buildbucket for the build status
[14:05:50.333] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:50.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:24:0) after 1m0s
[14:06:50.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:24:0)
[14:06:50.504] Timer tick, asking Buildbucket for the build status
[14:06:50.898] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:50.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:25:0) after 1m0s
[14:07:51.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:25:0)
[14:07:51.067] Timer tick, asking Buildbucket for the build status
[14:07:51.509] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:51.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:26:0) after 1m0s
[14:08:51.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:26:0)
[14:08:51.606] Timer tick, asking Buildbucket for the build status
[14:08:51.714] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:51.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:27:0) after 1m0s
[14:09:51.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:27:0)
[14:09:51.767] Timer tick, asking Buildbucket for the build status
[14:09:51.893] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:51.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:28:0) after 1m0s
[14:10:51.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:28:0)
[14:10:51.977] Timer tick, asking Buildbucket for the build status
[14:10:52.476] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:52.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:29:0) after 1m0s
[14:11:52.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:29:0)
[14:11:52.558] Timer tick, asking Buildbucket for the build status
[14:11:52.795] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:52.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:30:0) after 1m0s
[14:12:52.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:30:0)
[14:12:52.928] Timer tick, asking Buildbucket for the build status
[14:12:53.068] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:53.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:31:0) after 1m0s
[14:13:53.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:31:0)
[14:13:53.099] Timer tick, asking Buildbucket for the build status
[14:13:53.236] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:53.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:32:0) after 1m0s
[14:14:53.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:32:0)
[14:14:53.349] Timer tick, asking Buildbucket for the build status
[14:14:53.585] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:53.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:33:0) after 1m0s
[14:15:53.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:33:0)
[14:15:53.641] Timer tick, asking Buildbucket for the build status
[14:15:53.812] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:53.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:34:0) after 1m0s
[14:16:53.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:34:0)
[14:16:53.922] Timer tick, asking Buildbucket for the build status
[14:16:54.215] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:54.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:35:0) after 1m0s
[14:17:54.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:35:0)
[14:17:54.327] Timer tick, asking Buildbucket for the build status
[14:17:54.437] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:54.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:36:0) after 1m0s
[14:18:54.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:36:0)
[14:18:54.553] Timer tick, asking Buildbucket for the build status
[14:18:54.713] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:54.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:37:0) after 1m0s
[14:19:54.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:37:0)
[14:19:54.689] Timer tick, asking Buildbucket for the build status
[14:19:54.907] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:54.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:38:0) after 1m0s
[14:20:55.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:38:0)
[14:20:55.026] Timer tick, asking Buildbucket for the build status
[14:20:55.273] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:55.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:39:0) after 1m0s
[14:21:55.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:39:0)
[14:21:55.337] Timer tick, asking Buildbucket for the build status
[14:21:55.449] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:55.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:40:0) after 1m0s
[14:22:55.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:40:0)
[14:22:55.580] Timer tick, asking Buildbucket for the build status
[14:22:55.916] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:55.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:41:0) after 1m0s
[14:23:55.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:41:0)
[14:23:55.971] Timer tick, asking Buildbucket for the build status
[14:23:56.078] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:56.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:42:0) after 1m0s
[14:24:56.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:42:0)
[14:24:56.144] Timer tick, asking Buildbucket for the build status
[14:24:56.997] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:56.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:43:0) after 1m0s
[14:25:57.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:43:0)
[14:25:57.202] Timer tick, asking Buildbucket for the build status
[14:25:57.327] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:57.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:44:0) after 1m0s
[14:26:57.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:44:0)
[14:26:57.446] Timer tick, asking Buildbucket for the build status
[14:26:58.180] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:58.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:45:0) after 1m0s
[14:27:58.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:45:0)
[14:27:58.223] Timer tick, asking Buildbucket for the build status
[14:27:58.663] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:58.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:46:0) after 1m0s
[14:28:58.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:46:0)
[14:28:58.684] Timer tick, asking Buildbucket for the build status
[14:28:58.880] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:58.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:47:0) after 1m0s
[14:29:58.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:47:0)
[14:29:58.902] Timer tick, asking Buildbucket for the build status
[14:29:59.056] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:59.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:48:0) after 1m0s
[14:30:59.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:48:0)
[14:30:59.153] Timer tick, asking Buildbucket for the build status
[14:30:59.657] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:59.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:49:0) after 1m0s
[14:31:59.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:49:0)
[14:31:59.730] Timer tick, asking Buildbucket for the build status
[14:32:00.145] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:00.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:50:0) after 1m0s
[14:33:00.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:50:0)
[14:33:00.156] Timer tick, asking Buildbucket for the build status
[14:33:00.342] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:00.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:51:0) after 1m0s
[14:34:00.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:51:0)
[14:34:00.404] Timer tick, asking Buildbucket for the build status
[14:34:00.554] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:00.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:52:0) after 1m0s
[14:35:00.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:52:0)
[14:35:00.618] Timer tick, asking Buildbucket for the build status
[14:35:01.109] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:01.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:53:0) after 1m0s
[14:36:01.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:53:0)
[14:36:01.306] Timer tick, asking Buildbucket for the build status
[14:36:01.857] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:01.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:54:0) after 1m0s
[14:37:01.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:54:0)
[14:37:01.935] Timer tick, asking Buildbucket for the build status
[14:37:02.139] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:02.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:55:0) after 1m0s
[14:38:02.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:55:0)
[14:38:02.212] Timer tick, asking Buildbucket for the build status
[14:38:02.375] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:02.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:56:0) after 1m0s
[14:39:02.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:56:0)
[14:39:02.561] Timer tick, asking Buildbucket for the build status
[14:39:02.957] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:02.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:57:0) after 1m0s
[14:40:03.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:57:0)
[14:40:03.034] Timer tick, asking Buildbucket for the build status
[14:40:03.466] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:58:0) after 1m0s
[14:41:03.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:58:0)
[14:41:03.545] Timer tick, asking Buildbucket for the build status
[14:41:03.897] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:03.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:59:0) after 1m0s
[14:42:03.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:59:0)
[14:42:03.942] Timer tick, asking Buildbucket for the build status
[14:42:04.277] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:04.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:60:0) after 1m0s
[14:43:04.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:60:0)
[14:43:04.364] Timer tick, asking Buildbucket for the build status
[14:43:04.521] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:04.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:61:0) after 1m0s
[14:44:04.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:61:0)
[14:44:04.573] Timer tick, asking Buildbucket for the build status
[14:44:04.721] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:04.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:62:0) after 1m0s
[14:45:04.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:62:0)
[14:45:04.720] Timer tick, asking Buildbucket for the build status
[14:45:04.840] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:04.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:63:0) after 1m0s
[14:46:04.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:63:0)
[14:46:04.888] Timer tick, asking Buildbucket for the build status
[14:46:05.012] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:05.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:64:0) after 1m0s
[14:47:05.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:64:0)
[14:47:05.076] Timer tick, asking Buildbucket for the build status
[14:47:05.271] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:05.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:65:0) after 1m0s
[14:48:05.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:65:0)
[14:48:05.295] Timer tick, asking Buildbucket for the build status
[14:48:05.505] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:05.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:66:0) after 1m0s
[14:49:05.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:66:0)
[14:49:05.618] Timer tick, asking Buildbucket for the build status
[14:49:06.194] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:06.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:67:0) after 1m0s
[14:50:06.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:67:0)
[14:50:06.222] Timer tick, asking Buildbucket for the build status
[14:50:07.785] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:07.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:68:0) after 1m0s
[14:51:07.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:68:0)
[14:51:07.793] Timer tick, asking Buildbucket for the build status
[14:51:07.929] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:07.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:69:0) after 1m0s
[14:52:07.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:69:0)
[14:52:07.956] Timer tick, asking Buildbucket for the build status
[14:52:08.347] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:08.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:70:0) after 1m0s
[14:53:08.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:70:0)
[14:53:08.448] Timer tick, asking Buildbucket for the build status
[14:53:08.776] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:71:0) after 1m0s
[14:54:08.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:71:0)
[14:54:08.878] Timer tick, asking Buildbucket for the build status
[14:54:09.693] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:09.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:72:0) after 1m0s
[14:55:09.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:72:0)
[14:55:09.709] Timer tick, asking Buildbucket for the build status
[14:55:10.030] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:10.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:73:0) after 1m0s
[14:56:10.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:73:0)
[14:56:10.065] Timer tick, asking Buildbucket for the build status
[14:56:10.454] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:10.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:74:0) after 1m0s
[14:57:10.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:74:0)
[14:57:10.476] Timer tick, asking Buildbucket for the build status
[14:57:10.595] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:10.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:75:0) after 1m0s
[14:58:10.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:75:0)
[14:58:10.644] Timer tick, asking Buildbucket for the build status
[14:58:10.963] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:10.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:76:0) after 1m0s
[14:59:10.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:76:0)
[14:59:10.988] Timer tick, asking Buildbucket for the build status
[14:59:11.132] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:77:0) after 1m0s
[15:00:11.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:77:0)
[15:00:11.197] Timer tick, asking Buildbucket for the build status
[15:00:12.428] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:12.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:78:0) after 1m0s
[15:01:12.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:78:0)
[15:01:12.543] Timer tick, asking Buildbucket for the build status
[15:01:12.816] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:12.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:79:0) after 1m0s
[15:02:12.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:79:0)
[15:02:12.856] Timer tick, asking Buildbucket for the build status
[15:02:13.004] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:13.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:80:0) after 1m0s
[15:03:13.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:80:0)
[15:03:13.082] Timer tick, asking Buildbucket for the build status
[15:03:13.199] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:13.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:81:0) after 1m0s
[15:04:13.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:81:0)
[15:04:13.246] Timer tick, asking Buildbucket for the build status
[15:04:13.438] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:13.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:82:0) after 1m0s
[15:05:13.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:82:0)
[15:05:13.552] Timer tick, asking Buildbucket for the build status
[15:05:13.783] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:83:0) after 1m0s
[15:06:13.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:83:0)
[15:06:13.805] Timer tick, asking Buildbucket for the build status
[15:06:13.912] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:13.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:84:0) after 1m0s
[15:07:13.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:84:0)
[15:07:13.945] Timer tick, asking Buildbucket for the build status
[15:07:14.318] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:14.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:85:0) after 1m0s
[15:08:14.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:85:0)
[15:08:14.377] Timer tick, asking Buildbucket for the build status
[15:08:14.526] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:14.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:86:0) after 1m0s
[15:09:14.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:86:0)
[15:09:14.583] Timer tick, asking Buildbucket for the build status
[15:09:14.727] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:87:0) after 1m0s
[15:10:14.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:87:0)
[15:10:14.751] Timer tick, asking Buildbucket for the build status
[15:10:14.896] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:14.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:88:0) after 1m0s
[15:11:15.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:88:0)
[15:11:15.008] Timer tick, asking Buildbucket for the build status
[15:11:15.154] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:15.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:89:0) after 1m0s
[15:12:15.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:89:0)
[15:12:15.218] Timer tick, asking Buildbucket for the build status
[15:12:15.371] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:15.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:90:0) after 1m0s
[15:13:15.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:90:0)
[15:13:15.431] Timer tick, asking Buildbucket for the build status
[15:13:15.633] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:91:0) after 1m0s
[15:14:15.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:91:0)
[15:14:15.661] Timer tick, asking Buildbucket for the build status
[15:14:16.204] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:92:0) after 1m0s
[15:15:16.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:92:0)
[15:15:16.266] Timer tick, asking Buildbucket for the build status
[15:15:16.609] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:16.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:93:0) after 1m0s
[15:16:16.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:93:0)
[15:16:16.664] Timer tick, asking Buildbucket for the build status
[15:16:16.807] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:16.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:94:0) after 1m0s
[15:17:16.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:94:0)
[15:17:16.874] Timer tick, asking Buildbucket for the build status
[15:17:17.023] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:17.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:95:0) after 1m0s
[15:18:17.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:95:0)
[15:18:17.045] Timer tick, asking Buildbucket for the build status
[15:18:17.220] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:17.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:96:0) after 1m0s
[15:19:17.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:96:0)
[15:19:17.205] Timer tick, asking Buildbucket for the build status
[15:19:17.661] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:97:0) after 1m0s
[15:20:17.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:97:0)
[15:20:17.673] Timer tick, asking Buildbucket for the build status
[15:20:17.877] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:17.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:98:0) after 1m0s
[15:21:17.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:98:0)
[15:21:17.991] Timer tick, asking Buildbucket for the build status
[15:21:18.273] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:18.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:99:0) after 1m0s
[15:22:18.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:99:0)
[15:22:18.345] Timer tick, asking Buildbucket for the build status
[15:22:18.941] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:18.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:100:0) after 1m0s
[15:23:18.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:100:0)
[15:23:18.993] Timer tick, asking Buildbucket for the build status
[15:23:19.156] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:19.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:101:0) after 1m0s
[15:24:19.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:101:0)
[15:24:19.180] Timer tick, asking Buildbucket for the build status
[15:24:19.365] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:19.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:102:0) after 1m0s
[15:25:19.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:102:0)
[15:25:19.396] Timer tick, asking Buildbucket for the build status
[15:25:19.822] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:19.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:103:0) after 1m0s
[15:26:19.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:103:0)
[15:26:19.831] Timer tick, asking Buildbucket for the build status
[15:26:19.960] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:19.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:104:0) after 1m0s
[15:27:19.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:104:0)
[15:27:19.950] Timer tick, asking Buildbucket for the build status
[15:27:21.024] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:21.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:105:0) after 1m0s
[15:28:21.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:105:0)
[15:28:21.016] Timer tick, asking Buildbucket for the build status
[15:28:23.579] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:23.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:106:0) after 1m0s
[15:29:23.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:106:0)
[15:29:23.663] Timer tick, asking Buildbucket for the build status
[15:29:23.810] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:23.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:107:0) after 1m0s
[15:30:23.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:107:0)
[15:30:23.932] Timer tick, asking Buildbucket for the build status
[15:30:24.391] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:24.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:108:0) after 1m0s
[15:31:24.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:108:0)
[15:31:24.506] Timer tick, asking Buildbucket for the build status
[15:31:24.762] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:24.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:109:0) after 1m0s
[15:32:24.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:109:0)
[15:32:24.854] Timer tick, asking Buildbucket for the build status
[15:32:25.039] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:25.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:110:0) after 1m0s
[15:33:25.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:110:0)
[15:33:25.068] Timer tick, asking Buildbucket for the build status
[15:33:25.414] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:25.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:111:0) after 1m0s
[15:34:25.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:111:0)
[15:34:25.513] Timer tick, asking Buildbucket for the build status
[15:34:25.687] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:25.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:112:0) after 1m0s
[15:35:25.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:112:0)
[15:35:25.853] Timer tick, asking Buildbucket for the build status
[15:35:26.311] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:26.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:113:0) after 1m0s
[15:36:26.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:113:0)
[15:36:26.380] Timer tick, asking Buildbucket for the build status
[15:36:26.992] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:26.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:114:0) after 1m0s
[15:37:26.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:114:0)
[15:37:26.995] Timer tick, asking Buildbucket for the build status
[15:37:27.169] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:27.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:115:0) after 1m0s
[15:38:27.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:115:0)
[15:38:27.183] Timer tick, asking Buildbucket for the build status
[15:38:27.567] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:27.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:116:0) after 1m0s
[15:39:27.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:116:0)
[15:39:27.631] Timer tick, asking Buildbucket for the build status
[15:39:28.664] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:28.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:117:0) after 1m0s
[15:40:28.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:117:0)
[15:40:28.688] Timer tick, asking Buildbucket for the build status
[15:40:28.867] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:28.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:118:0) after 1m0s
[15:41:28.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:118:0)
[15:41:28.942] Timer tick, asking Buildbucket for the build status
[15:41:29.171] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:29.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:119:0) after 1m0s
[15:42:29.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:119:0)
[15:42:29.200] Timer tick, asking Buildbucket for the build status
[15:42:29.317] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:29.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:120:0) after 1m0s
[15:43:29.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:120:0)
[15:43:29.446] Timer tick, asking Buildbucket for the build status
[15:43:29.690] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:29.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:121:0) after 1m0s
[15:44:29.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:121:0)
[15:44:29.827] Timer tick, asking Buildbucket for the build status
[15:44:30.029] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:30.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:122:0) after 1m0s
[15:45:30.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:122:0)
[15:45:30.096] Timer tick, asking Buildbucket for the build status
[15:45:30.304] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:30.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:123:0) after 1m0s
[15:46:30.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:123:0)
[15:46:30.437] Timer tick, asking Buildbucket for the build status
[15:46:30.847] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:30.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:124:0) after 1m0s
[15:47:30.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:124:0)
[15:47:30.902] Timer tick, asking Buildbucket for the build status
[15:47:31.046] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:125:0) after 1m0s
[15:48:31.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:125:0)
[15:48:31.151] Timer tick, asking Buildbucket for the build status
[15:48:31.306] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:31.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:126:0) after 1m0s
[15:49:31.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:126:0)
[15:49:31.344] Timer tick, asking Buildbucket for the build status
[15:49:31.446] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:31.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:127:0) after 1m0s
[15:50:31.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:127:0)
[15:50:31.492] Timer tick, asking Buildbucket for the build status
[15:50:31.597] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:31.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:128:0) after 1m0s
[15:51:31.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:128:0)
[15:51:31.664] Timer tick, asking Buildbucket for the build status
[15:51:31.957] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:31.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:129:0) after 1m0s
[15:52:32.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:129:0)
[15:52:32.056] Timer tick, asking Buildbucket for the build status
[15:52:32.216] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:32.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:130:0) after 1m0s
[15:53:32.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:130:0)
[15:53:32.304] Timer tick, asking Buildbucket for the build status
[15:53:32.490] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:32.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:131:0) after 1m0s
[15:54:32.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:131:0)
[15:54:32.616] Timer tick, asking Buildbucket for the build status
[15:54:32.820] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:32.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:132:0) after 1m0s
[15:55:32.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:132:0)
[15:55:32.875] Timer tick, asking Buildbucket for the build status
[15:55:33.079] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:133:0) after 1m0s
[15:56:33.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:133:0)
[15:56:33.107] Timer tick, asking Buildbucket for the build status
[15:56:33.338] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:33.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:134:0) after 1m0s
[15:57:33.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:134:0)
[15:57:33.371] Timer tick, asking Buildbucket for the build status
[15:57:33.575] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:33.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:135:0) after 1m0s
[15:58:33.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:135:0)
[15:58:33.702] Timer tick, asking Buildbucket for the build status
[15:58:34.042] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:34.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:136:0) after 1m0s
[15:59:34.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:136:0)
[15:59:34.121] Timer tick, asking Buildbucket for the build status
[15:59:34.316] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:34.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:137:0) after 1m0s
[16:00:34.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:137:0)
[16:00:34.346] Timer tick, asking Buildbucket for the build status
[16:00:34.680] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:34.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:138:0) after 1m0s
[16:01:34.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:138:0)
[16:01:34.714] Timer tick, asking Buildbucket for the build status
[16:01:34.878] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:34.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:139:0) after 1m0s
[16:02:34.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:139:0)
[16:02:34.945] Timer tick, asking Buildbucket for the build status
[16:02:35.725] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:35.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:140:0) after 1m0s
[16:03:35.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:140:0)
[16:03:35.775] Timer tick, asking Buildbucket for the build status
[16:03:35.901] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:35.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:141:0) after 1m0s
[16:04:35.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:141:0)
[16:04:35.972] Timer tick, asking Buildbucket for the build status
[16:04:36.390] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:36.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:142:0) after 1m0s
[16:05:36.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:142:0)
[16:05:36.440] Timer tick, asking Buildbucket for the build status
[16:05:36.693] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:36.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:143:0) after 1m0s
[16:06:36.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:143:0)
[16:06:36.770] Timer tick, asking Buildbucket for the build status
[16:06:37.175] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:37.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:144:0) after 1m0s
[16:07:37.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:144:0)
[16:07:37.215] Timer tick, asking Buildbucket for the build status
[16:07:37.335] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:37.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:145:0) after 1m0s
[16:08:37.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:145:0)
[16:08:37.358] Timer tick, asking Buildbucket for the build status
[16:08:37.475] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:37.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:146:0) after 1m0s
[16:09:37.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:146:0)
[16:09:37.542] Timer tick, asking Buildbucket for the build status
[16:09:37.958] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:37.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:147:0) after 1m0s
[16:10:38.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:147:0)
[16:10:38.047] Timer tick, asking Buildbucket for the build status
[16:10:38.270] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:38.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:148:0) after 1m0s
[16:11:38.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:148:0)
[16:11:38.405] Timer tick, asking Buildbucket for the build status
[16:11:38.518] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:38.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:149:0) after 1m0s
[16:12:38.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:149:0)
[16:12:38.695] Timer tick, asking Buildbucket for the build status
[16:12:38.853] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:38.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:150:0) after 1m0s
[16:13:38.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:150:0)
[16:13:38.982] Timer tick, asking Buildbucket for the build status
[16:13:39.374] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:39.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:151:0) after 1m0s
[16:14:39.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:151:0)
[16:14:39.519] Timer tick, asking Buildbucket for the build status
[16:14:39.651] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:152:0) after 1m0s
[16:15:39.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:152:0)
[16:15:39.841] Timer tick, asking Buildbucket for the build status
[16:15:39.967] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:39.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:153:0) after 1m0s
[16:16:40.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:153:0)
[16:16:40.023] Timer tick, asking Buildbucket for the build status
[16:16:40.144] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:40.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:154:0) after 1m0s
[16:17:40.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:154:0)
[16:17:40.244] Timer tick, asking Buildbucket for the build status
[16:17:40.404] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:40.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:155:0) after 1m0s
[16:18:40.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:155:0)
[16:18:40.449] Timer tick, asking Buildbucket for the build status
[16:18:40.651] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:40.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:156:0) after 1m0s
[16:19:40.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:156:0)
[16:19:40.734] Timer tick, asking Buildbucket for the build status
[16:19:41.123] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:41.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:157:0) after 1m0s
[16:20:41.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:157:0)
[16:20:41.222] Timer tick, asking Buildbucket for the build status
[16:20:41.387] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:41.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:158:0) after 1m0s
[16:21:41.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:158:0)
[16:21:41.450] Timer tick, asking Buildbucket for the build status
[16:21:41.649] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:41.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:159:0) after 1m0s
[16:22:41.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:159:0)
[16:22:41.880] Timer tick, asking Buildbucket for the build status
[16:22:42.030] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:42.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:160:0) after 1m0s
[16:23:42.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:160:0)
[16:23:42.139] Timer tick, asking Buildbucket for the build status
[16:23:42.482] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:42.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:161:0) after 1m0s
[16:24:42.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:161:0)
[16:24:42.562] Timer tick, asking Buildbucket for the build status
[16:24:43.019] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:43.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:162:0) after 1m0s
[16:25:43.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:162:0)
[16:25:43.089] Timer tick, asking Buildbucket for the build status
[16:25:43.261] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:43.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:163:0) after 1m0s
[16:26:43.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:163:0)
[16:26:43.376] Timer tick, asking Buildbucket for the build status
[16:26:43.656] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:43.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:164:0) after 1m0s
[16:27:43.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:164:0)
[16:27:43.764] Timer tick, asking Buildbucket for the build status
[16:27:43.952] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:165:0) after 1m0s
[16:28:44.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:165:0)
[16:28:44.141] Timer tick, asking Buildbucket for the build status
[16:28:44.295] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:44.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:166:0) after 1m0s
[16:29:44.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:166:0)
[16:29:44.428] Timer tick, asking Buildbucket for the build status
[16:29:44.603] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:44.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:167:0) after 1m0s
[16:30:44.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:167:0)
[16:30:44.776] Timer tick, asking Buildbucket for the build status
[16:30:44.967] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:44.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:168:0) after 1m0s
[16:31:45.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:168:0)
[16:31:45.101] Timer tick, asking Buildbucket for the build status
[16:31:45.562] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:45.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:169:0) after 1m0s
[16:32:45.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:169:0)
[16:32:45.625] Timer tick, asking Buildbucket for the build status
[16:32:45.809] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:45.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:170:0) after 1m0s
[16:33:45.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:170:0)
[16:33:45.859] Timer tick, asking Buildbucket for the build status
[16:33:45.989] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:45.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:171:0) after 1m0s
[16:34:46.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:171:0)
[16:34:46.044] Timer tick, asking Buildbucket for the build status
[16:34:46.208] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:46.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:172:0) after 1m0s
[16:35:46.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:172:0)
[16:35:46.290] Timer tick, asking Buildbucket for the build status
[16:35:46.392] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:46.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:173:0) after 1m0s
[16:36:46.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:173:0)
[16:36:46.507] Timer tick, asking Buildbucket for the build status
[16:36:46.629] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:174:0) after 1m0s
[16:37:46.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:174:0)
[16:37:46.846] Timer tick, asking Buildbucket for the build status
[16:37:47.142] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:47.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:175:0) after 1m0s
[16:38:47.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:175:0)
[16:38:47.234] Timer tick, asking Buildbucket for the build status
[16:38:47.618] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:47.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:176:0) after 1m0s
[16:39:47.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:176:0)
[16:39:47.617] Timer tick, asking Buildbucket for the build status
[16:39:47.768] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:177:0) after 1m0s
[16:40:47.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:177:0)
[16:40:47.822] Timer tick, asking Buildbucket for the build status
[16:40:48.141] Build 8880863617776456672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:48.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9046293680314420384:178:0) after 1m0s
[16:41:32.114] Received PubSub notification, asking Buildbucket for the build status
[16:41:32.183] Build 8880863617776456672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:41:32.183] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1588956091135757",
"created_by": "project:chromium",
"created_ts": "1588945482427830",
"id": "8880863617776456672",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8db5101c01b1390825e1e42e6085ea6d92d15ed9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-ma4s\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16445, \"got_angle_revision\": \"555de000d75e902a1ae2b26de378e0f7037eef29\", \"got_dawn_revision\": \"70ffa0c28561c35ed6ba1e98f42f5a38e3c6f57b\", \"got_nacl_revision\": \"08ef20f1933cc724a25911b4da99a9e7355cafa0\", \"got_revision\": \"8db5101c01b1390825e1e42e6085ea6d92d15ed9\", \"got_revision_cp\": \"refs/heads/master@{#766829}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"2dd864470e310d173d35fa95ca3a14d216734aab\", \"got_v8_revision\": \"a3433d822f603cc0642c0a84bf291b0f90a3c493\", \"got_v8_revision_cp\": \"refs/heads/8.4.316@{#1}\", \"got_webrtc_revision\": \"04e1bab1b324e08b8dec4bf617e2afb13b6bde3b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31185}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8db5101c01b1390825e1e42e6085ea6d92d15ed9\"}, \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-ma4s\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"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\": [\"5050-4c62a25\"], \"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": "1588945485472873",
"status": "COMPLETED",
"status_changed_ts": "1588956091555331",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16445",
"builder:Windows deterministic",
"buildset:commit/git/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8db5101c01b1390825e1e42e6085ea6d92d15ed9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046293680314420384",
"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/8880863617776456672/+/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:4c0d597f8cf44510",
"user_agent:luci-scheduler"
],
"updated_ts": "1588956091569291",
"url": "https://ci.chromium.org/b/8880863617776456672",
"utcnow_ts": "1588956092175373"
}
}
[16:41:32.183] Invocation finished in 2h56m51.560447416s with status SUCCEEDED