[01:13:02.847] New invocation is queued and will start shortly
[01:13:04.183] Starting the invocation (attempt 1)
[01:13:04.273] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:13:04.274] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:13:04.274] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9099521388054913824",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"57cbbcd9cc392bd00bad619b42e4d90070e1067f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9099521388054913824",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"gitiles_ref:refs/heads/master"
]
}
[01:13:05.790] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538183584414446",
"id": "8934091325748056656",
"lease_expiration_ts": "1538327585505228",
"lease_key": "670284734",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"57cbbcd9cc392bd00bad619b42e4d90070e1067f\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538183585680997",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10232",
"builder:Windows deterministic",
"buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099521388054913824",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10232",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934091325748056656",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8934091325748056656/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9099521388054913824",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:216ff455080a4f94ea455f4ef2ee62b8417f1092",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:403bb465e1a4b710",
"user_agent:luci-scheduler"
],
"updated_ts": "1538183585681082",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10232",
"utcnow_ts": "1538183585773894"
}
}
[01:13:05.790] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10232
[01:13:05.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:2:0) after 1m0s
[01:13:07.176] Received PubSub notification, asking Buildbucket for the build status
[01:13:07.228] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:05.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:2:0)
[01:14:05.824] Timer tick, asking Buildbucket for the build status
[01:14:05.871] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:05.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:4:0) after 1m0s
[01:15:05.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:4:0)
[01:15:05.909] Timer tick, asking Buildbucket for the build status
[01:15:05.997] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:05.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:5:0) after 1m0s
[01:16:06.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:5:0)
[01:16:06.034] Timer tick, asking Buildbucket for the build status
[01:16:06.235] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:6:0) after 1m0s
[01:17:06.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:6:0)
[01:17:06.274] Timer tick, asking Buildbucket for the build status
[01:17:06.378] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:06.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:7:0) after 1m0s
[01:18:06.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:7:0)
[01:18:06.403] Timer tick, asking Buildbucket for the build status
[01:18:06.522] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:8:0) after 1m0s
[01:19:06.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:8:0)
[01:19:06.553] Timer tick, asking Buildbucket for the build status
[01:19:06.653] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:06.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:9:0) after 1m0s
[01:20:06.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:9:0)
[01:20:06.724] Timer tick, asking Buildbucket for the build status
[01:20:06.776] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:10:0) after 1m0s
[01:21:06.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:10:0)
[01:21:06.802] Timer tick, asking Buildbucket for the build status
[01:21:06.933] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:06.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:11:0) after 1m0s
[01:22:06.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:11:0)
[01:22:06.957] Timer tick, asking Buildbucket for the build status
[01:22:07.005] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:07.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:12:0) after 1m0s
[01:23:07.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:12:0)
[01:23:07.041] Timer tick, asking Buildbucket for the build status
[01:23:07.234] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:07.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:13:0) after 1m0s
[01:24:07.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:13:0)
[01:24:07.268] Timer tick, asking Buildbucket for the build status
[01:24:07.354] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:07.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:14:0) after 1m0s
[01:25:07.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:14:0)
[01:25:07.494] Timer tick, asking Buildbucket for the build status
[01:25:07.590] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:07.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:15:0) after 1m0s
[01:26:07.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:15:0)
[01:26:07.627] Timer tick, asking Buildbucket for the build status
[01:26:07.693] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:07.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:16:0) after 1m0s
[01:27:07.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:16:0)
[01:27:07.803] Timer tick, asking Buildbucket for the build status
[01:27:07.953] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:07.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:17:0) after 1m0s
[01:28:07.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:17:0)
[01:28:07.992] Timer tick, asking Buildbucket for the build status
[01:28:08.129] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:08.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:18:0) after 1m0s
[01:29:08.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:18:0)
[01:29:08.192] Timer tick, asking Buildbucket for the build status
[01:29:08.280] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:08.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:19:0) after 1m0s
[01:30:08.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:19:0)
[01:30:08.305] Timer tick, asking Buildbucket for the build status
[01:30:08.371] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:08.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:20:0) after 1m0s
[01:31:08.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:20:0)
[01:31:08.471] Timer tick, asking Buildbucket for the build status
[01:31:08.531] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:08.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:21:0) after 1m0s
[01:32:08.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:21:0)
[01:32:08.590] Timer tick, asking Buildbucket for the build status
[01:32:08.714] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:08.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:22:0) after 1m0s
[01:33:08.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:22:0)
[01:33:08.762] Timer tick, asking Buildbucket for the build status
[01:33:08.822] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:08.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:23:0) after 1m0s
[01:34:08.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:23:0)
[01:34:08.853] Timer tick, asking Buildbucket for the build status
[01:34:08.929] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:08.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:24:0) after 1m0s
[01:35:08.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:24:0)
[01:35:08.947] Timer tick, asking Buildbucket for the build status
[01:35:09.127] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:09.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:25:0) after 1m0s
[01:36:09.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:25:0)
[01:36:09.194] Timer tick, asking Buildbucket for the build status
[01:36:09.252] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:09.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:26:0) after 1m0s
[01:37:09.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:26:0)
[01:37:09.273] Timer tick, asking Buildbucket for the build status
[01:37:09.390] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:09.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:27:0) after 1m0s
[01:38:09.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:27:0)
[01:38:09.414] Timer tick, asking Buildbucket for the build status
[01:38:09.472] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:09.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:28:0) after 1m0s
[01:39:09.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:28:0)
[01:39:09.495] Timer tick, asking Buildbucket for the build status
[01:39:09.564] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:09.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:29:0) after 1m0s
[01:40:09.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:29:0)
[01:40:09.598] Timer tick, asking Buildbucket for the build status
[01:40:09.649] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:09.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:30:0) after 1m0s
[01:41:09.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:30:0)
[01:41:09.686] Timer tick, asking Buildbucket for the build status
[01:41:09.747] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:09.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:31:0) after 1m0s
[01:42:09.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:31:0)
[01:42:09.782] Timer tick, asking Buildbucket for the build status
[01:42:09.865] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:09.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:32:0) after 1m0s
[01:43:09.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:32:0)
[01:43:09.902] Timer tick, asking Buildbucket for the build status
[01:43:09.952] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:09.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:33:0) after 1m0s
[01:44:09.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:33:0)
[01:44:09.990] Timer tick, asking Buildbucket for the build status
[01:44:10.093] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:10.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:34:0) after 1m0s
[01:45:10.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:34:0)
[01:45:10.123] Timer tick, asking Buildbucket for the build status
[01:45:10.254] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:10.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:35:0) after 1m0s
[01:46:10.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:35:0)
[01:46:10.284] Timer tick, asking Buildbucket for the build status
[01:46:10.371] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:10.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:36:0) after 1m0s
[01:47:10.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:36:0)
[01:47:10.506] Timer tick, asking Buildbucket for the build status
[01:47:10.575] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:10.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:37:0) after 1m0s
[01:48:10.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:37:0)
[01:48:10.686] Timer tick, asking Buildbucket for the build status
[01:48:10.765] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:10.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:38:0) after 1m0s
[01:49:10.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:38:0)
[01:49:10.811] Timer tick, asking Buildbucket for the build status
[01:49:10.871] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:10.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:39:0) after 1m0s
[01:50:10.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:39:0)
[01:50:10.920] Timer tick, asking Buildbucket for the build status
[01:50:11.023] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:40:0) after 1m0s
[01:51:11.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:40:0)
[01:51:11.089] Timer tick, asking Buildbucket for the build status
[01:51:11.176] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:11.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:41:0) after 1m0s
[01:52:11.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:41:0)
[01:52:11.215] Timer tick, asking Buildbucket for the build status
[01:52:11.369] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:11.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:42:0) after 1m0s
[01:53:11.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:42:0)
[01:53:11.420] Timer tick, asking Buildbucket for the build status
[01:53:11.478] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:11.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:43:0) after 1m0s
[01:54:11.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:43:0)
[01:54:11.499] Timer tick, asking Buildbucket for the build status
[01:54:11.576] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:11.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:44:0) after 1m0s
[01:55:11.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:44:0)
[01:55:11.599] Timer tick, asking Buildbucket for the build status
[01:55:11.718] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:11.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:45:0) after 1m0s
[01:56:11.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:45:0)
[01:56:11.828] Timer tick, asking Buildbucket for the build status
[01:56:11.898] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:11.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:46:0) after 1m0s
[01:57:11.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:46:0)
[01:57:11.950] Timer tick, asking Buildbucket for the build status
[01:57:11.982] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:11.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:47:0) after 1m0s
[01:58:12.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:47:0)
[01:58:12.026] Timer tick, asking Buildbucket for the build status
[01:58:12.071] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:12.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:48:0) after 1m0s
[01:59:12.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:48:0)
[01:59:12.198] Timer tick, asking Buildbucket for the build status
[01:59:12.326] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:12.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:49:0) after 1m0s
[02:00:12.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:49:0)
[02:00:12.418] Timer tick, asking Buildbucket for the build status
[02:00:12.512] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:12.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:50:0) after 1m0s
[02:01:12.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:50:0)
[02:01:12.535] Timer tick, asking Buildbucket for the build status
[02:01:12.595] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:12.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:51:0) after 1m0s
[02:02:12.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:51:0)
[02:02:12.628] Timer tick, asking Buildbucket for the build status
[02:02:12.687] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:12.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:52:0) after 1m0s
[02:03:12.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:52:0)
[02:03:12.727] Timer tick, asking Buildbucket for the build status
[02:03:12.801] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:12.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:53:0) after 1m0s
[02:04:12.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:53:0)
[02:04:12.824] Timer tick, asking Buildbucket for the build status
[02:04:12.890] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:12.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:54:0) after 1m0s
[02:05:12.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:54:0)
[02:05:12.920] Timer tick, asking Buildbucket for the build status
[02:05:12.983] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:12.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:55:0) after 1m0s
[02:06:13.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:55:0)
[02:06:13.037] Timer tick, asking Buildbucket for the build status
[02:06:13.112] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:13.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:56:0) after 1m0s
[02:07:13.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:56:0)
[02:07:13.155] Timer tick, asking Buildbucket for the build status
[02:07:13.235] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:13.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:57:0) after 1m0s
[02:08:13.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:57:0)
[02:08:13.281] Timer tick, asking Buildbucket for the build status
[02:08:13.441] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:58:0) after 1m0s
[02:09:13.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:58:0)
[02:09:13.473] Timer tick, asking Buildbucket for the build status
[02:09:13.575] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:13.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:59:0) after 1m0s
[02:10:13.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:59:0)
[02:10:13.672] Timer tick, asking Buildbucket for the build status
[02:10:13.814] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:13.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:60:0) after 1m0s
[02:11:13.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:60:0)
[02:11:13.839] Timer tick, asking Buildbucket for the build status
[02:11:13.899] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:13.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:61:0) after 1m0s
[02:12:13.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:61:0)
[02:12:13.949] Timer tick, asking Buildbucket for the build status
[02:12:14.037] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:14.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:62:0) after 1m0s
[02:13:14.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:62:0)
[02:13:14.064] Timer tick, asking Buildbucket for the build status
[02:13:14.104] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:14.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:63:0) after 1m0s
[02:14:14.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:63:0)
[02:14:14.158] Timer tick, asking Buildbucket for the build status
[02:14:14.362] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:14.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:64:0) after 1m0s
[02:15:14.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:64:0)
[02:15:14.491] Timer tick, asking Buildbucket for the build status
[02:15:14.585] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:14.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:65:0) after 1m0s
[02:16:14.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:65:0)
[02:16:14.608] Timer tick, asking Buildbucket for the build status
[02:16:14.662] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:14.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:66:0) after 1m0s
[02:17:14.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:66:0)
[02:17:14.685] Timer tick, asking Buildbucket for the build status
[02:17:14.744] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:14.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:67:0) after 1m0s
[02:18:14.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:67:0)
[02:18:14.772] Timer tick, asking Buildbucket for the build status
[02:18:14.842] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:14.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:68:0) after 1m0s
[02:19:14.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:68:0)
[02:19:14.990] Timer tick, asking Buildbucket for the build status
[02:19:15.073] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:15.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:69:0) after 1m0s
[02:20:15.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:69:0)
[02:20:15.104] Timer tick, asking Buildbucket for the build status
[02:20:15.235] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:15.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:70:0) after 1m0s
[02:21:15.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:70:0)
[02:21:15.259] Timer tick, asking Buildbucket for the build status
[02:21:15.419] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:15.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:71:0) after 1m0s
[02:22:15.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:71:0)
[02:22:15.443] Timer tick, asking Buildbucket for the build status
[02:22:15.530] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:15.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:72:0) after 1m0s
[02:23:15.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:72:0)
[02:23:15.656] Timer tick, asking Buildbucket for the build status
[02:23:15.696] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:15.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:73:0) after 1m0s
[02:24:15.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:73:0)
[02:24:15.747] Timer tick, asking Buildbucket for the build status
[02:24:15.799] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:15.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:74:0) after 1m0s
[02:25:15.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:74:0)
[02:25:15.857] Timer tick, asking Buildbucket for the build status
[02:25:15.932] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:15.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:75:0) after 1m0s
[02:26:16.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:75:0)
[02:26:16.101] Timer tick, asking Buildbucket for the build status
[02:26:16.388] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:16.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:76:0) after 1m0s
[02:27:16.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:76:0)
[02:27:16.432] Timer tick, asking Buildbucket for the build status
[02:27:16.479] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:16.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:77:0) after 1m0s
[02:28:16.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:77:0)
[02:28:16.575] Timer tick, asking Buildbucket for the build status
[02:28:16.614] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:78:0) after 1m0s
[02:29:16.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:78:0)
[02:29:16.643] Timer tick, asking Buildbucket for the build status
[02:29:16.701] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:16.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:79:0) after 1m0s
[02:30:16.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:79:0)
[02:30:16.808] Timer tick, asking Buildbucket for the build status
[02:30:16.886] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:16.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:80:0) after 1m0s
[02:31:16.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:80:0)
[02:31:16.925] Timer tick, asking Buildbucket for the build status
[02:31:16.959] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:16.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:81:0) after 1m0s
[02:32:16.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:81:0)
[02:32:16.982] Timer tick, asking Buildbucket for the build status
[02:32:17.019] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:17.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:82:0) after 1m0s
[02:33:17.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:82:0)
[02:33:17.051] Timer tick, asking Buildbucket for the build status
[02:33:17.117] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:17.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:83:0) after 1m0s
[02:34:17.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:83:0)
[02:34:17.169] Timer tick, asking Buildbucket for the build status
[02:34:17.211] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:17.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:84:0) after 1m0s
[02:35:17.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:84:0)
[02:35:17.268] Timer tick, asking Buildbucket for the build status
[02:35:17.427] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:17.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:85:0) after 1m0s
[02:36:17.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:85:0)
[02:36:17.463] Timer tick, asking Buildbucket for the build status
[02:36:17.512] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:17.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:86:0) after 1m0s
[02:37:17.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:86:0)
[02:37:17.541] Timer tick, asking Buildbucket for the build status
[02:37:17.636] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:17.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:87:0) after 1m0s
[02:38:17.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:87:0)
[02:38:17.666] Timer tick, asking Buildbucket for the build status
[02:38:17.735] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:17.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:88:0) after 1m0s
[02:39:17.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:88:0)
[02:39:17.811] Timer tick, asking Buildbucket for the build status
[02:39:17.936] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:17.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:89:0) after 1m0s
[02:40:17.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:89:0)
[02:40:17.962] Timer tick, asking Buildbucket for the build status
[02:40:18.009] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:18.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:90:0) after 1m0s
[02:41:18.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:90:0)
[02:41:18.195] Timer tick, asking Buildbucket for the build status
[02:41:18.292] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:91:0) after 1m0s
[02:42:18.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:91:0)
[02:42:18.331] Timer tick, asking Buildbucket for the build status
[02:42:18.371] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:18.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:92:0) after 1m0s
[02:43:18.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:92:0)
[02:43:18.398] Timer tick, asking Buildbucket for the build status
[02:43:18.463] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:18.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:93:0) after 1m0s
[02:44:18.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:93:0)
[02:44:18.528] Timer tick, asking Buildbucket for the build status
[02:44:18.587] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:18.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:94:0) after 1m0s
[02:45:18.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:94:0)
[02:45:18.610] Timer tick, asking Buildbucket for the build status
[02:45:18.647] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:18.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:95:0) after 1m0s
[02:46:18.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:95:0)
[02:46:18.672] Timer tick, asking Buildbucket for the build status
[02:46:18.769] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:18.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:96:0) after 1m0s
[02:47:18.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:96:0)
[02:47:18.846] Timer tick, asking Buildbucket for the build status
[02:47:18.884] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:18.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:97:0) after 1m0s
[02:48:18.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:97:0)
[02:48:18.923] Timer tick, asking Buildbucket for the build status
[02:48:19.000] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:19.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:98:0) after 1m0s
[02:49:19.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:98:0)
[02:49:19.045] Timer tick, asking Buildbucket for the build status
[02:49:19.116] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:19.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:99:0) after 1m0s
[02:50:19.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:99:0)
[02:50:19.136] Timer tick, asking Buildbucket for the build status
[02:50:19.255] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:19.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:100:0) after 1m0s
[02:51:19.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:100:0)
[02:51:19.307] Timer tick, asking Buildbucket for the build status
[02:51:19.462] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:19.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:101:0) after 1m0s
[02:52:19.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:101:0)
[02:52:19.485] Timer tick, asking Buildbucket for the build status
[02:52:19.690] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:19.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:102:0) after 1m0s
[02:53:19.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:102:0)
[02:53:19.903] Timer tick, asking Buildbucket for the build status
[02:53:19.972] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:19.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:103:0) after 1m0s
[02:54:20.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:103:0)
[02:54:20.076] Timer tick, asking Buildbucket for the build status
[02:54:20.200] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:20.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:104:0) after 1m0s
[02:55:20.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:104:0)
[02:55:20.288] Timer tick, asking Buildbucket for the build status
[02:55:20.533] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:20.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:105:0) after 1m0s
[02:56:20.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:105:0)
[02:56:20.578] Timer tick, asking Buildbucket for the build status
[02:56:20.710] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:20.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:106:0) after 1m0s
[02:57:20.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:106:0)
[02:57:20.763] Timer tick, asking Buildbucket for the build status
[02:57:20.832] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:20.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:107:0) after 1m0s
[02:58:20.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:107:0)
[02:58:20.990] Timer tick, asking Buildbucket for the build status
[02:58:21.037] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:21.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:108:0) after 1m0s
[02:59:21.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:108:0)
[02:59:21.142] Timer tick, asking Buildbucket for the build status
[02:59:21.442] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:21.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:109:0) after 1m0s
[03:00:21.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:109:0)
[03:00:21.553] Timer tick, asking Buildbucket for the build status
[03:00:21.615] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:21.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:110:0) after 1m0s
[03:01:21.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:110:0)
[03:01:21.764] Timer tick, asking Buildbucket for the build status
[03:01:21.845] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:21.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:111:0) after 1m0s
[03:02:21.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:111:0)
[03:02:21.981] Timer tick, asking Buildbucket for the build status
[03:02:22.028] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:22.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:112:0) after 1m0s
[03:03:22.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:112:0)
[03:03:22.187] Timer tick, asking Buildbucket for the build status
[03:03:22.280] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:22.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:113:0) after 1m0s
[03:04:22.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:113:0)
[03:04:22.308] Timer tick, asking Buildbucket for the build status
[03:04:22.421] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:22.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:114:0) after 1m0s
[03:05:22.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:114:0)
[03:05:22.566] Timer tick, asking Buildbucket for the build status
[03:05:22.631] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:115:0) after 1m0s
[03:06:22.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:115:0)
[03:06:22.687] Timer tick, asking Buildbucket for the build status
[03:06:22.741] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:22.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:116:0) after 1m0s
[03:07:22.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:116:0)
[03:07:22.869] Timer tick, asking Buildbucket for the build status
[03:07:22.918] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:117:0) after 1m0s
[03:08:23.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:117:0)
[03:08:23.073] Timer tick, asking Buildbucket for the build status
[03:08:23.191] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:23.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:118:0) after 1m0s
[03:09:23.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:118:0)
[03:09:23.256] Timer tick, asking Buildbucket for the build status
[03:09:23.304] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:23.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:119:0) after 1m0s
[03:10:23.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:119:0)
[03:10:23.369] Timer tick, asking Buildbucket for the build status
[03:10:23.433] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:120:0) after 1m0s
[03:11:23.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:120:0)
[03:11:23.470] Timer tick, asking Buildbucket for the build status
[03:11:23.554] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:23.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:121:0) after 1m0s
[03:12:23.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:121:0)
[03:12:23.622] Timer tick, asking Buildbucket for the build status
[03:12:23.754] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:23.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:122:0) after 1m0s
[03:13:23.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:122:0)
[03:13:23.826] Timer tick, asking Buildbucket for the build status
[03:13:23.970] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:23.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:123:0) after 1m0s
[03:14:24.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:123:0)
[03:14:24.032] Timer tick, asking Buildbucket for the build status
[03:14:24.074] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:124:0) after 1m0s
[03:15:24.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:124:0)
[03:15:24.122] Timer tick, asking Buildbucket for the build status
[03:15:24.319] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:125:0) after 1m0s
[03:16:24.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:125:0)
[03:16:24.361] Timer tick, asking Buildbucket for the build status
[03:16:24.405] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:24.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:126:0) after 1m0s
[03:17:24.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:126:0)
[03:17:24.486] Timer tick, asking Buildbucket for the build status
[03:17:24.521] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:24.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:127:0) after 1m0s
[03:18:24.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:127:0)
[03:18:24.562] Timer tick, asking Buildbucket for the build status
[03:18:24.646] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:128:0) after 1m0s
[03:19:24.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:128:0)
[03:19:24.677] Timer tick, asking Buildbucket for the build status
[03:19:24.796] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:24.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:129:0) after 1m0s
[03:20:24.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:129:0)
[03:20:24.992] Timer tick, asking Buildbucket for the build status
[03:20:25.127] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:130:0) after 1m0s
[03:21:25.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:130:0)
[03:21:25.154] Timer tick, asking Buildbucket for the build status
[03:21:25.194] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:25.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:131:0) after 1m0s
[03:22:25.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:131:0)
[03:22:25.246] Timer tick, asking Buildbucket for the build status
[03:22:25.314] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:25.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:132:0) after 1m0s
[03:23:25.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:132:0)
[03:23:25.377] Timer tick, asking Buildbucket for the build status
[03:23:25.460] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:133:0) after 1m0s
[03:24:25.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:133:0)
[03:24:25.504] Timer tick, asking Buildbucket for the build status
[03:24:25.580] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:25.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:134:0) after 1m0s
[03:25:25.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:134:0)
[03:25:25.665] Timer tick, asking Buildbucket for the build status
[03:25:25.829] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:25.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:135:0) after 1m0s
[03:26:25.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:135:0)
[03:26:25.855] Timer tick, asking Buildbucket for the build status
[03:26:25.911] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:25.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:136:0) after 1m0s
[03:27:25.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:136:0)
[03:27:25.933] Timer tick, asking Buildbucket for the build status
[03:27:26.159] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:26.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:137:0) after 1m0s
[03:28:26.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:137:0)
[03:28:26.277] Timer tick, asking Buildbucket for the build status
[03:28:26.344] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:26.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:138:0) after 1m0s
[03:29:26.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:138:0)
[03:29:26.405] Timer tick, asking Buildbucket for the build status
[03:29:26.670] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:26.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:139:0) after 1m0s
[03:30:26.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:139:0)
[03:30:26.724] Timer tick, asking Buildbucket for the build status
[03:30:26.818] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:26.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:140:0) after 1m0s
[03:31:26.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:140:0)
[03:31:26.846] Timer tick, asking Buildbucket for the build status
[03:31:26.919] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:26.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:141:0) after 1m0s
[03:32:26.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:141:0)
[03:32:26.956] Timer tick, asking Buildbucket for the build status
[03:32:27.046] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:27.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:142:0) after 1m0s
[03:33:27.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:142:0)
[03:33:27.097] Timer tick, asking Buildbucket for the build status
[03:33:27.184] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:143:0) after 1m0s
[03:34:27.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:143:0)
[03:34:27.209] Timer tick, asking Buildbucket for the build status
[03:34:27.252] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:144:0) after 1m0s
[03:35:27.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:144:0)
[03:35:27.422] Timer tick, asking Buildbucket for the build status
[03:35:27.483] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:27.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:145:0) after 1m0s
[03:36:27.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:145:0)
[03:36:27.509] Timer tick, asking Buildbucket for the build status
[03:36:27.834] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:27.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:146:0) after 1m0s
[03:37:27.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:146:0)
[03:37:27.858] Timer tick, asking Buildbucket for the build status
[03:37:27.914] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:27.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:147:0) after 1m0s
[03:38:27.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:147:0)
[03:38:27.947] Timer tick, asking Buildbucket for the build status
[03:38:28.036] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:28.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:148:0) after 1m0s
[03:39:28.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:148:0)
[03:39:28.077] Timer tick, asking Buildbucket for the build status
[03:39:28.137] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:28.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:149:0) after 1m0s
[03:40:28.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:149:0)
[03:40:28.170] Timer tick, asking Buildbucket for the build status
[03:40:28.225] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:28.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:150:0) after 1m0s
[03:41:28.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:150:0)
[03:41:28.266] Timer tick, asking Buildbucket for the build status
[03:41:28.401] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:28.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:151:0) after 1m0s
[03:42:28.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:151:0)
[03:42:28.430] Timer tick, asking Buildbucket for the build status
[03:42:28.614] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:28.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:152:0) after 1m0s
[03:43:28.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:152:0)
[03:43:28.659] Timer tick, asking Buildbucket for the build status
[03:43:28.728] Build 8934091325748056656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:28.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099521388054913824:153:0) after 1m0s
[03:44:15.971] Received PubSub notification, asking Buildbucket for the build status
[03:44:16.011] Build 8934091325748056656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:44:16.012] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1538192654936132",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538183584414446",
"id": "8934091325748056656",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"57cbbcd9cc392bd00bad619b42e4d90070e1067f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8934091325748056656/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3793-c7dcd56\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"2ebbdab4bfb1ed9dfe52ce756b34829207dbe25f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"57cbbcd9cc392bd00bad619b42e4d90070e1067f\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24875}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#595278}\", \"branch\": \"refs/heads/master\", \"revision\": \"57cbbcd9cc392bd00bad619b42e4d90070e1067f\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"1ee9160a2e0bc6381caca2b8c42f7ce5507619bc\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"c0b82333ab279be7efc4752fd24f9c87b00310b5\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538183584414446, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9099521388054913824\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8934091325748056656\"}}, \"got_v8_revision\": \"686dfc3f13a5fe766bfc25f2a84a8c64d45aa4e7\", \"got_v8_revision_cp\": \"refs/heads/7.1.201@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10232, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"d44ded5c9df80c3a8614f3a1add129825e9fc6b0\", \"notification_helper_unittests\": \"e8788b77a38f921c8465c9b622768cc0671145ce\", \"gpu_perftests\": \"91a4734a291e95a7655f9d927b6bda82a959199f\", \"vr_common_unittests\": \"6b518c4d8c2f01b456815a4f7ab1fdd06b9b07fc\", \"telemetry_unittests\": \"41fc7b57c7f9c8c5845ffd5cc7d2d7b52448de56\", \"load_library_perf_tests\": \"d6bc47a2cc723052810d879d251e0881a3ad8745\", \"devtools_closure_compile\": \"47b1e90c378ab4480e13476081e61e888c71bb2f\", \"chromedriver_py_tests\": \"ea43646f69ab40e4d3f2d24bf5e59c548715bb78\", \"mojo_core_unittests\": \"5cda50efe2fd6e8e92e42c4a123029436576d613\", \"install_static_unittests\": \"c7e40c1f359b5188715d200d01ec6694918cbf62\", \"leveldb_service_unittests\": \"96ea0e92f4b59a84917174cd30264bf566265173\", \"mini_installer_tests\": \"d08c9a430e0959b60a0939b428e7db8cb171e48a\", \"jingle_unittests\": \"a0b92b6efb1793956b4b7d099c3d6bd2b6e228cd\", \"sbox_integration_tests\": \"a363451eeef65750be0349fe96581edc684c43ce\", \"angle_unittests\": \"421b2bc09cbdf24eace5c7f57c8b0cf75950498b\", \"cast_unittests\": \"9b6bdaf993171ed65f943679597d17db22c27786\", \"cc_unittests\": \"5e03412db4848f9556882f40eda3d6c1c0ac3c5d\", \"blink_common_unittests\": \"b87e5f88bfd10ed220507069c858a21d55240baf\", \"crashpad_tests\": \"1bf659547d1dd33e87b3923954eb87f9ce02e472\", \"telemetry_perf_tests_without_chrome\": \"54e616db3d29df2afb599f112a1213251f724da3\", \"metrics_python_tests\": \"f95b0e49247ef3a6ca3e61b77ec9e90ea94bdf49\", \"message_center_unittests\": \"44d15b1cc5a16e31b7230cd8394f828751e6f462\", \"ppapi_unittests\": \"f19d43c249632db71d0f9bd45fbc07f2470b8cbd\", \"extensions_unittests\": \"d1c09ac75b4e955769b88516a6c377eacc754a99\", \"gl_unittests_ozone\": \"72ab8cb78b64f609c364d0908b2e225b6035fcd4\", \"app_shell_unittests\": \"4a564c82f0a50ffdfa36c13fc45f5a1386a74508\", \"chrome_app_unittests\": \"5edb2534e3a97e6b024e1284858b04eb28e31ed8\", \"gl_unittests\": \"72ab8cb78b64f609c364d0908b2e225b6035fcd4\", \"gcm_unit_tests\": \"56be48493cbb8186ec7be42992f1db8c55eabb4d\", \"views_unittests\": \"e28be76dff5e1936a5436ada6aafb8bbc0e3a02b\", \"content_shell_crash_test\": \"1ffe4e19280d0da120a35db31f8ff549aefbec83\", \"ui_base_unittests\": \"84149420165fd8057c4b6ddcca8ca6210119dc5a\", \"gles2_conform_test\": \"cf3bdc47f7765161bb0e3ca41cb14fab0e3abff6\", \"cronet_unittests\": \"c91d87cee7728bf4d5a5b9cd5aed41edf94db38d\", \"performance_test_suite\": \"80b3ee4392e15eb915cce4090780fa7d3bcbfbf1\", \"wm_unittests\": \"e7e636a9a4da9da7e99b3ad3cb7a2e8f7b38bab8\", \"boringssl_crypto_tests\": \"fb1def146e428706affbfd7067ba24bcbcf74ba3\", \"gin_unittests\": \"3c9a12e2deb250cfd0aab5a6999c71687981fa1c\", \"performance_browser_tests\": \"6e1896ad3b31d33973d25e582bf07f25824123b6\", \"extensions_browsertests\": \"0ab2b5d49b6ef4bab6e9438233acb7752214b81f\", \"webkit_python_tests\": \"07a12f1a1fbe21d02a56a0fd2b0a907bc9053cbf\", \"headless_unittests\": \"79e9e9cabb5f0fa233e4228344bd3e3d15231c27\", \"webkit_layout_tests\": \"0c5f3337b2886b58eb3fb5d0516bfa7cd8cafe32\", \"vr_pixeltests\": \"cc84c5907ec5442429779da3a197f9be8c487bad\", \"setup_unittests\": \"742dea19b7ca9ebdc520071ad56f86f282d4c75d\", \"webkit_unit_tests\": \"97ecd538dfe9b45d3cf6a76fff3b1d42813967e8\", \"content_unittests\": \"3bc75a59629474f2c2db9b4a00f64a073ac793b0\", \"performance_webview_test_suite\": \"2e2847d6c51a468b231415ff16972f45d63d405f\", \"wtf_unittests\": \"79e5e375f99559003ca61409ac2c820dcf608921\", \"webkit_layout_tests_exparchive\": \"fbec4055d8ac3aa2795f1358b292ad168cc8f0cb\", \"chrome_cleaner_unittests\": \"97f035171c8df382d1c9d5a2cd66c97338332fcf\", \"traffic_annotation_auditor_unittests\": \"a072e8afd94a9d7344eca4e23bcc40b8bffe6cc9\", \"libjingle_xmpp_unittests\": \"6cafc849e1de9d78edc47a8b2ce6ea837873abac\", \"remoting_unittests\": \"111dd9b1d282ea3f5328cddf035696f5d7276501\", \"vr_common_perftests\": \"26fd2479d6a26a8e959d269aafb44a00437d3c92\", \"filesystem_service_unittests\": \"7953ff48da150185be2cc18a03c76fcbae08a552\", \"chrome_elf_import_unittests\": \"3f48c9c52b90a68dbdb27662e037b5c5831ee2e8\", \"installer_util_unittests\": \"50d16b83dac49719430572b6ace6bc76499def86\", \"gfx_unittests\": \"d21b250e572caa2b0bdb8df1042ddbf96ad5b11f\", \"headless_browsertests\": \"450c1629a83db35e86389ea0297668e9cddbb4e1\", \"capture_unittests\": \"9f7fcc61bf0077188fc998a02bbc2f8d4b62c932\", \"chrome_elf_unittests\": \"f0b7cfcbedffef5912c62c40b76d7badd70ebe6a\", \"telemetry_gpu_unittests\": \"60882a35f8c94557f9c4684440a2715659a7475c\", \"command_buffer_perftests\": \"526be6d850b25831c0edc3a99bacfad6b58837d2\", \"media_unittests\": \"2c4bbaac13a182d12101d7aa2fa27e3422f9b1c6\", \"chromedriver_unittests\": \"976e723f30ff87a3389ce47ea6e2493b4cd77e62\", \"views_mus_interactive_ui_tests\": \"020e315ebded0001b9b278689806654e0b185c61\", \"storage_unittests\": \"0f0131f05d98caaea4606667b17b2b966e4261b3\", \"media_service_unittests\": \"6906a70e40c7bc9bacb6988d1f6c3364663f9b89\", \"compositor_unittests\": \"ba334a26e4bf4dc18d2b3395189920dc3a66709a\", \"latency_unittests\": \"dfc35d10f60d741e9721f7aa8dd602d24b2df18f\", \"video_decode_accelerator_unittest\": \"225f930190e26c46ae52e0e5b6e4b76cab0f2c85\", \"swiftshader_unittests\": \"4844f4b45426d04ae42e54c5294f33765beadf26\", \"telemetry_perf_unittests\": \"106a935bc7709e865c6e5c4bc6403acda6b79342\", \"media_blink_unittests\": \"075891a582a5ba0955532fcc1f04898823bdee2f\", \"views_mus_unittests\": \"dee816d42ec6072ab1ac1eab6e99aa30a2c5f932\", \"components_unittests\": \"aea5d31025968f8530ecdc481b9a8f34010469e4\", \"snapshot_unittests\": \"466eb759b244fa13915669547f9f5f6b7a8d3c4f\", \"accessibility_unittests\": \"412f8ec75cc3274de1b8088ebb89a01f29f84fa8\", \"net_perftests\": \"a1923a32c6de305fe3151aae7284b8e6a87e845d\", \"aura_unittests\": \"0de49f1ab23cd879d98ad7f838d1b46f3438d621\", \"services_unittests\": \"4b7ecf7bd58678a5c50185b4b9a6393c443a70de\", \"components_perftests\": \"5613f5b98f8f5f5a8b3a9a71b383932f7957c4d7\", \"events_unittests\": \"d9b738d3821c3ac2a9d7b8a03366f0adea095660\", \"tracing_perftests\": \"2053860340f4fc43b3de8bf13266716f77349313\", \"chromedriver_replay_unittests\": \"50c6aef6c493544165526b2b516579428eb4b618\", \"ui_touch_selection_unittests\": \"d423acd4bef6354c4d51ca40757ba84d2ffc43bd\", \"cacheinvalidation_unittests\": \"50aa568eeba5bbb15906a37c38a0bee722a66052\", \"viz_unittests\": \"007b808ce948b91470b961137599d8fcee9997d7\", \"browser_tests\": \"d969fe028abf0d3158020e80ae781f5c4d20b7e3\", \"net_unittests\": \"88cfb099e51a6994a1cc6fd39b8505750445a7e5\", \"midi_unittests\": \"6de621fb187e4f289f47e5eb44e9b2e1f9c9df90\", \"boringssl_ssl_tests\": \"1b008338744acc35ab2543a8cdfeae6bc6ee9dee\", \"sbox_validation_tests\": \"dc74dcf2db103cdc2d955335e573d46b902c4a9d\", \"elevation_service_unittests\": \"9732b76f18068e1effc7c881e37384339b4d7298\", \"gpu_unittests\": \"843206869909cc59a7f375556e5876906c60122e\", \"native_theme_unittests\": \"6e285d45565c20958b24fffd72df1efc6b7ffe74\", \"interactive_ui_tests\": \"f6b42e741844f63d3834be9d8915a8dcc3a21d87\", \"mojo_unittests\": \"4a53184f5a305626addfd0169bffe621ddb8f664\", \"url_unittests\": \"2d2dbb47d8889f0475c72284a188a28e2a145b1f\", \"media_perftests\": \"aab522b5e7a67b3bdf4fe66b34ee7fd83c8116e3\", \"cronet_tests\": \"a8ec494f1dc916abe925e428dc6bff3d2ca8dc72\", \"google_apis_unittests\": \"3636a95b289670143cd53140cba5b0c3f55abbd3\", \"telemetry_gpu_integration_test\": \"2e544d0e93bf76781ef076f20dfd64e9e2fcaccf\", \"blink_heap_unittests\": \"cea5ebef86df4051457dbf88383e0cd372721d5c\", \"base_unittests\": \"0883dfd98c7a7d7444e6db51b372100120bd3a5f\", \"sync_integration_tests\": \"2cfd9666d66b4c273b84e532d670c3eabf074395\", \"sql_unittests\": \"cb1fc114a9430ffd16fd05813138562d4ab57713\", \"courgette_unittests\": \"2a32c59713354f9d730c7b00406bfd4546e35f4b\", \"blink_fuzzer_unittests\": \"dcd3ecc937eb033c2860c13088abe2b110d00a31\", \"gl_tests\": \"191e32d108340899db9ec3f196b52295852d06d9\", \"zucchini_unittests\": \"27bcd6b32699af478de4a9109de05600d6b1d1ff\", \"ipc_tests\": \"c4587a30c5d09f91a631d365229e196cce2924f4\", \"angle_end2end_tests\": \"40bb7017d5fcdfe2b722fac7c6a3108d5b81b33a\", \"blink_platform_unittests\": \"4698dc9952212d074446fbb2481fe56e717fa961\", \"components_browsertests\": \"6ff56e3f047e0d0f6c5da6e5b6a9a4dfda3cc0d9\", \"views_perftests\": \"a2462bd7b50540523c23ccffeaeb8c29ddbd779d\", \"angle_perftests\": \"89fbd701f62a65a96249688bcd12994d559960ef\", \"display_unittests\": \"7f3b98fd342ad9fc94bd2314ada5ef30682beea2\", \"sbox_unittests\": \"ece9f6ed04ec94de9fdf1ba47552bb419acebc1f\", \"service_manager_unittests\": \"508baf59da8a00c98d42061e3ebfad5eefc3557c\", \"pdf_unittests\": \"b8b2814df9e610c74ef70001b22280cd63194720\", \"skia_unittests\": \"76a0a6bac70b57e967e71895bd85997dbebfdaf4\", \"angle_white_box_tests\": \"0de9147155a1bf601aff4116ef8e54e3ba6a243b\", \"crypto_unittests\": \"8efbf22abfaeb541501fab0c2016d3722a112fc7\", \"nacl_loader_unittests\": \"5f342f9805ac58e9e97b3975a3284857e2b7aaaf\", \"unit_tests\": \"6664d0d08733b3a3e72b9bd03d558a3150fe1a10\", \"content_browsertests\": \"7d7d4bc80b7282aefeb4dc1abc13bea1b1f6955e\", \"printing_unittests\": \"df2a3f48e70d5840bc8912add95cde3e5b2cf9dd\", \"device_unittests\": \"4d6b8f2d2d8940bfab1dba2587c0f49d5e1f5eac\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538183586137105",
"status": "COMPLETED",
"status_changed_ts": "1538192655549071",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10232",
"builder:Windows deterministic",
"buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099521388054913824",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10232",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934091325748056656",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cbbcd9cc392bd00bad619b42e4d90070e1067f",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8934091325748056656/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9099521388054913824",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:216ff455080a4f94ea455f4ef2ee62b8417f1092",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:403bb465e1a4b710",
"user_agent:luci-scheduler"
],
"updated_ts": "1538192655551228",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10232",
"utcnow_ts": "1538192656000304"
}
}
[03:44:16.012] Invocation finished in 2h31m13.181726834s with status SUCCEEDED