[16:59:42.332] New invocation is queued and will start shortly
[16:59:45.158] Starting the invocation (attempt 1)
[16:59:45.189] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:59:45.189] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:59:45.189] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9108883913985593616",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fe177065bdb13e403f8a15c8e3bcdebffb4dd17c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9108883913985593616",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"gitiles_ref:refs/heads/master"
]
}
[16:59:48.901] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1529254785389147",
"experimental": true,
"id": "8943453850114085712",
"lease_expiration_ts": "1529290786426835",
"lease_key": "1529951276",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe177065bdb13e403f8a15c8e3bcdebffb4dd17c\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1529254788752630",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/54",
"builder:Windows deterministic",
"buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9108883913985593616",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"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/54",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943453850114085712",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"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/8943453850114085712/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"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:9108883913985593616",
"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:7b1b5d239a2e04e83d3627884ca58c970e37b2b0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e2781bceeb86c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1529254788752743",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/54",
"utcnow_ts": "1529254788881935"
}
}
[16:59:48.901] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/54
[16:59:48.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:2:0) after 1m0s
[17:00:48.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:2:0)
[17:00:48.920] Timer tick, asking Buildbucket for the build status
[17:00:48.978] Build 8943453850114085712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:48.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:3:0) after 1m0s
[17:01:11.149] Received PubSub notification, asking Buildbucket for the build status
[17:01:11.195] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:48.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:3:0)
[17:01:48.997] Timer tick, asking Buildbucket for the build status
[17:01:49.058] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:49.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:5:0) after 1m0s
[17:02:49.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:5:0)
[17:02:49.087] Timer tick, asking Buildbucket for the build status
[17:02:49.289] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:49.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:6:0) after 1m0s
[17:03:49.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:6:0)
[17:03:49.309] Timer tick, asking Buildbucket for the build status
[17:03:49.365] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:49.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:7:0) after 1m0s
[17:04:49.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:7:0)
[17:04:49.383] Timer tick, asking Buildbucket for the build status
[17:04:49.497] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:8:0) after 1m0s
[17:05:49.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:8:0)
[17:05:49.519] Timer tick, asking Buildbucket for the build status
[17:05:49.659] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:49.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:9:0) after 1m0s
[17:06:50.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:9:0)
[17:06:50.342] Timer tick, asking Buildbucket for the build status
[17:06:50.411] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:50.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:10:0) after 1m0s
[17:07:50.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:10:0)
[17:07:50.446] Timer tick, asking Buildbucket for the build status
[17:07:50.500] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:50.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:11:0) after 1m0s
[17:08:50.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:11:0)
[17:08:50.519] Timer tick, asking Buildbucket for the build status
[17:08:50.650] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:50.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:12:0) after 1m0s
[17:09:50.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:12:0)
[17:09:50.690] Timer tick, asking Buildbucket for the build status
[17:09:50.925] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:50.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:13:0) after 1m0s
[17:10:50.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:13:0)
[17:10:50.978] Timer tick, asking Buildbucket for the build status
[17:10:51.204] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:51.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:14:0) after 1m0s
[17:11:51.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:14:0)
[17:11:51.334] Timer tick, asking Buildbucket for the build status
[17:11:51.425] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:51.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:15:0) after 1m0s
[17:12:51.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:15:0)
[17:12:51.537] Timer tick, asking Buildbucket for the build status
[17:12:51.686] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:51.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:16:0) after 1m0s
[17:13:51.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:16:0)
[17:13:51.705] Timer tick, asking Buildbucket for the build status
[17:13:51.831] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:51.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:17:0) after 1m0s
[17:14:51.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:17:0)
[17:14:51.848] Timer tick, asking Buildbucket for the build status
[17:14:51.900] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:51.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:18:0) after 1m0s
[17:15:51.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:18:0)
[17:15:51.921] Timer tick, asking Buildbucket for the build status
[17:15:51.983] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:51.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:19:0) after 1m0s
[17:16:52.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:19:0)
[17:16:52.012] Timer tick, asking Buildbucket for the build status
[17:16:52.209] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:52.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:20:0) after 1m0s
[17:17:52.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:20:0)
[17:17:52.247] Timer tick, asking Buildbucket for the build status
[17:17:52.300] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:52.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:21:0) after 1m0s
[17:18:52.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:21:0)
[17:18:52.317] Timer tick, asking Buildbucket for the build status
[17:18:52.371] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:52.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:22:0) after 1m0s
[17:19:52.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:22:0)
[17:19:52.491] Timer tick, asking Buildbucket for the build status
[17:19:52.593] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:52.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:23:0) after 1m0s
[17:20:52.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:23:0)
[17:20:52.616] Timer tick, asking Buildbucket for the build status
[17:20:52.680] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:52.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:24:0) after 1m0s
[17:21:52.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:24:0)
[17:21:52.736] Timer tick, asking Buildbucket for the build status
[17:21:52.792] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:52.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:25:0) after 1m0s
[17:22:52.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:25:0)
[17:22:52.814] Timer tick, asking Buildbucket for the build status
[17:22:52.892] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:52.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:26:0) after 1m0s
[17:23:52.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:26:0)
[17:23:52.910] Timer tick, asking Buildbucket for the build status
[17:23:53.010] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:53.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:27:0) after 1m0s
[17:24:53.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:27:0)
[17:24:53.030] Timer tick, asking Buildbucket for the build status
[17:24:53.135] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:53.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:28:0) after 1m0s
[17:25:53.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:28:0)
[17:25:53.153] Timer tick, asking Buildbucket for the build status
[17:25:58.642] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:58.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:29:0) after 1m0s
[17:26:58.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:29:0)
[17:26:58.661] Timer tick, asking Buildbucket for the build status
[17:26:59.027] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:30:0) after 1m0s
[17:27:59.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:30:0)
[17:27:59.049] Timer tick, asking Buildbucket for the build status
[17:27:59.120] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:59.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:31:0) after 1m0s
[17:28:59.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:31:0)
[17:28:59.149] Timer tick, asking Buildbucket for the build status
[17:28:59.331] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:59.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:32:0) after 1m0s
[17:29:59.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:32:0)
[17:29:59.348] Timer tick, asking Buildbucket for the build status
[17:29:59.407] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:33:0) after 1m0s
[17:30:59.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:33:0)
[17:30:59.444] Timer tick, asking Buildbucket for the build status
[17:30:59.499] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:59.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:34:0) after 1m0s
[17:31:59.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:34:0)
[17:31:59.520] Timer tick, asking Buildbucket for the build status
[17:31:59.550] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:59.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:35:0) after 1m0s
[17:32:59.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:35:0)
[17:32:59.568] Timer tick, asking Buildbucket for the build status
[17:32:59.844] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:59.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:36:0) after 1m0s
[17:33:59.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:36:0)
[17:33:59.863] Timer tick, asking Buildbucket for the build status
[17:33:59.919] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:59.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:37:0) after 1m0s
[17:34:59.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:37:0)
[17:34:59.938] Timer tick, asking Buildbucket for the build status
[17:34:59.993] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:59.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:38:0) after 1m0s
[17:36:00.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:38:0)
[17:36:00.019] Timer tick, asking Buildbucket for the build status
[17:36:00.090] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:00.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:39:0) after 1m0s
[17:37:00.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:39:0)
[17:37:00.107] Timer tick, asking Buildbucket for the build status
[17:37:00.175] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:00.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:40:0) after 1m0s
[17:38:00.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:40:0)
[17:38:00.229] Timer tick, asking Buildbucket for the build status
[17:38:05.697] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:41:0) after 1m0s
[17:39:05.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:41:0)
[17:39:05.724] Timer tick, asking Buildbucket for the build status
[17:39:05.782] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:05.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:42:0) after 1m0s
[17:40:05.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:42:0)
[17:40:05.798] Timer tick, asking Buildbucket for the build status
[17:40:05.855] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:05.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:43:0) after 1m0s
[17:41:05.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:43:0)
[17:41:05.923] Timer tick, asking Buildbucket for the build status
[17:41:06.024] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:06.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:44:0) after 1m0s
[17:42:06.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:44:0)
[17:42:06.047] Timer tick, asking Buildbucket for the build status
[17:42:06.105] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:06.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:45:0) after 1m0s
[17:43:06.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:45:0)
[17:43:06.122] Timer tick, asking Buildbucket for the build status
[17:43:06.277] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:06.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:46:0) after 1m0s
[17:44:06.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:46:0)
[17:44:06.307] Timer tick, asking Buildbucket for the build status
[17:44:06.338] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:06.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:47:0) after 1m0s
[17:45:06.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:47:0)
[17:45:06.358] Timer tick, asking Buildbucket for the build status
[17:45:06.458] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:48:0) after 1m0s
[17:46:06.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:48:0)
[17:46:06.499] Timer tick, asking Buildbucket for the build status
[17:46:06.596] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:06.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:49:0) after 1m0s
[17:47:06.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:49:0)
[17:47:06.617] Timer tick, asking Buildbucket for the build status
[17:47:06.686] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:06.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:50:0) after 1m0s
[17:48:06.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:50:0)
[17:48:06.706] Timer tick, asking Buildbucket for the build status
[17:48:06.791] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:51:0) after 1m0s
[17:49:06.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:51:0)
[17:49:06.923] Timer tick, asking Buildbucket for the build status
[17:49:07.024] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:07.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:52:0) after 1m0s
[17:50:07.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:52:0)
[17:50:07.089] Timer tick, asking Buildbucket for the build status
[17:50:07.190] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:07.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:53:0) after 1m0s
[17:51:07.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:53:0)
[17:51:07.345] Timer tick, asking Buildbucket for the build status
[17:51:07.552] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:07.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:54:0) after 1m0s
[17:52:07.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:54:0)
[17:52:07.573] Timer tick, asking Buildbucket for the build status
[17:52:07.637] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:07.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:55:0) after 1m0s
[17:53:07.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:55:0)
[17:53:07.656] Timer tick, asking Buildbucket for the build status
[17:53:07.696] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:07.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:56:0) after 1m0s
[17:54:07.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:56:0)
[17:54:07.821] Timer tick, asking Buildbucket for the build status
[17:54:07.971] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:07.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:57:0) after 1m0s
[17:55:08.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:57:0)
[17:55:08.018] Timer tick, asking Buildbucket for the build status
[17:55:08.091] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:08.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:58:0) after 1m0s
[17:56:08.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:58:0)
[17:56:08.328] Timer tick, asking Buildbucket for the build status
[17:56:08.447] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:08.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:59:0) after 1m0s
[17:57:08.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:59:0)
[17:57:08.481] Timer tick, asking Buildbucket for the build status
[17:57:08.538] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:08.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:60:0) after 1m0s
[17:58:08.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:60:0)
[17:58:08.593] Timer tick, asking Buildbucket for the build status
[17:58:08.652] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:08.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:61:0) after 1m0s
[17:59:08.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:61:0)
[17:59:08.803] Timer tick, asking Buildbucket for the build status
[17:59:08.900] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:08.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:62:0) after 1m0s
[18:00:09.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:62:0)
[18:00:09.012] Timer tick, asking Buildbucket for the build status
[18:00:09.243] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:09.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:63:0) after 1m0s
[18:01:09.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:63:0)
[18:01:09.283] Timer tick, asking Buildbucket for the build status
[18:01:09.346] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:09.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:64:0) after 1m0s
[18:02:09.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:64:0)
[18:02:09.422] Timer tick, asking Buildbucket for the build status
[18:02:09.480] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:09.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:65:0) after 1m0s
[18:03:09.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:65:0)
[18:03:09.504] Timer tick, asking Buildbucket for the build status
[18:03:09.558] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:09.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:66:0) after 1m0s
[18:04:09.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:66:0)
[18:04:09.624] Timer tick, asking Buildbucket for the build status
[18:04:09.674] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:09.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:67:0) after 1m0s
[18:05:09.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:67:0)
[18:05:09.806] Timer tick, asking Buildbucket for the build status
[18:05:09.875] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:09.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:68:0) after 1m0s
[18:06:10.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:68:0)
[18:06:10.024] Timer tick, asking Buildbucket for the build status
[18:06:10.099] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:10.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:69:0) after 1m0s
[18:07:10.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:69:0)
[18:07:10.123] Timer tick, asking Buildbucket for the build status
[18:07:10.219] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:10.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:70:0) after 1m0s
[18:08:10.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:70:0)
[18:08:10.295] Timer tick, asking Buildbucket for the build status
[18:08:10.619] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:10.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:71:0) after 1m0s
[18:09:10.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:71:0)
[18:09:10.641] Timer tick, asking Buildbucket for the build status
[18:09:10.716] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:10.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:72:0) after 1m0s
[18:10:10.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:72:0)
[18:10:10.745] Timer tick, asking Buildbucket for the build status
[18:10:10.957] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:10.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:73:0) after 1m0s
[18:11:10.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:73:0)
[18:11:10.981] Timer tick, asking Buildbucket for the build status
[18:11:11.118] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:11.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:74:0) after 1m0s
[18:12:11.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:74:0)
[18:12:11.158] Timer tick, asking Buildbucket for the build status
[18:12:11.224] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:11.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:75:0) after 1m0s
[18:13:11.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:75:0)
[18:13:11.243] Timer tick, asking Buildbucket for the build status
[18:13:11.302] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:11.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:76:0) after 1m0s
[18:14:11.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:76:0)
[18:14:11.328] Timer tick, asking Buildbucket for the build status
[18:14:11.386] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:11.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:77:0) after 1m0s
[18:15:11.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:77:0)
[18:15:11.407] Timer tick, asking Buildbucket for the build status
[18:15:11.459] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:11.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:78:0) after 1m0s
[18:16:11.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:78:0)
[18:16:11.481] Timer tick, asking Buildbucket for the build status
[18:16:11.550] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:11.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:79:0) after 1m0s
[18:17:11.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:79:0)
[18:17:11.567] Timer tick, asking Buildbucket for the build status
[18:17:11.602] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:11.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:80:0) after 1m0s
[18:18:11.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:80:0)
[18:18:11.622] Timer tick, asking Buildbucket for the build status
[18:18:11.680] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:81:0) after 1m0s
[18:19:11.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:81:0)
[18:19:11.706] Timer tick, asking Buildbucket for the build status
[18:19:11.754] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:11.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:82:0) after 1m0s
[18:20:11.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:82:0)
[18:20:11.784] Timer tick, asking Buildbucket for the build status
[18:20:11.977] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:11.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:83:0) after 1m0s
[18:21:12.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:83:0)
[18:21:12.005] Timer tick, asking Buildbucket for the build status
[18:21:12.234] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:12.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:84:0) after 1m0s
[18:22:12.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:84:0)
[18:22:12.254] Timer tick, asking Buildbucket for the build status
[18:22:12.436] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:12.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:85:0) after 1m0s
[18:23:12.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:85:0)
[18:23:12.457] Timer tick, asking Buildbucket for the build status
[18:23:12.511] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:12.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:86:0) after 1m0s
[18:24:12.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:86:0)
[18:24:12.601] Timer tick, asking Buildbucket for the build status
[18:24:12.647] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:12.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:87:0) after 1m0s
[18:25:12.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:87:0)
[18:25:12.668] Timer tick, asking Buildbucket for the build status
[18:25:12.734] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:12.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:88:0) after 1m0s
[18:26:12.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:88:0)
[18:26:12.754] Timer tick, asking Buildbucket for the build status
[18:26:12.810] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:89:0) after 1m0s
[18:27:12.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:89:0)
[18:27:12.909] Timer tick, asking Buildbucket for the build status
[18:27:12.943] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:12.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:90:0) after 1m0s
[18:28:12.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:90:0)
[18:28:12.971] Timer tick, asking Buildbucket for the build status
[18:28:13.026] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:13.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:91:0) after 1m0s
[18:29:13.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:91:0)
[18:29:13.065] Timer tick, asking Buildbucket for the build status
[18:29:13.098] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:13.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:92:0) after 1m0s
[18:30:13.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:92:0)
[18:30:13.122] Timer tick, asking Buildbucket for the build status
[18:30:13.192] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:13.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:93:0) after 1m0s
[18:31:13.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:93:0)
[18:31:13.219] Timer tick, asking Buildbucket for the build status
[18:31:13.537] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:13.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:94:0) after 1m0s
[18:32:13.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:94:0)
[18:32:13.574] Timer tick, asking Buildbucket for the build status
[18:32:13.631] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:13.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:95:0) after 1m0s
[18:33:13.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:95:0)
[18:33:13.653] Timer tick, asking Buildbucket for the build status
[18:33:13.743] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:13.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:96:0) after 1m0s
[18:34:13.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:96:0)
[18:34:13.762] Timer tick, asking Buildbucket for the build status
[18:34:13.801] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:13.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:97:0) after 1m0s
[18:35:13.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:97:0)
[18:35:13.836] Timer tick, asking Buildbucket for the build status
[18:35:13.912] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:13.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:98:0) after 1m0s
[18:36:13.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:98:0)
[18:36:13.937] Timer tick, asking Buildbucket for the build status
[18:36:14.002] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:14.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:99:0) after 1m0s
[18:37:14.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:99:0)
[18:37:14.079] Timer tick, asking Buildbucket for the build status
[18:37:14.171] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:14.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:100:0) after 1m0s
[18:38:14.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:100:0)
[18:38:14.205] Timer tick, asking Buildbucket for the build status
[18:38:14.244] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:14.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:101:0) after 1m0s
[18:39:14.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:101:0)
[18:39:14.374] Timer tick, asking Buildbucket for the build status
[18:39:14.437] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:14.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:102:0) after 1m0s
[18:40:14.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:102:0)
[18:40:14.467] Timer tick, asking Buildbucket for the build status
[18:40:14.769] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:14.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:103:0) after 1m0s
[18:41:14.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:103:0)
[18:41:14.789] Timer tick, asking Buildbucket for the build status
[18:41:15.382] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:15.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:104:0) after 1m0s
[18:42:15.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:104:0)
[18:42:15.409] Timer tick, asking Buildbucket for the build status
[18:42:15.464] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:15.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:105:0) after 1m0s
[18:43:15.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:105:0)
[18:43:15.503] Timer tick, asking Buildbucket for the build status
[18:43:15.541] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:15.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:106:0) after 1m0s
[18:44:15.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:106:0)
[18:44:15.560] Timer tick, asking Buildbucket for the build status
[18:44:15.729] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:15.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:107:0) after 1m0s
[18:45:15.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:107:0)
[18:45:15.751] Timer tick, asking Buildbucket for the build status
[18:45:15.955] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:15.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:108:0) after 1m0s
[18:46:15.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:108:0)
[18:46:15.979] Timer tick, asking Buildbucket for the build status
[18:46:16.522] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:16.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:109:0) after 1m0s
[18:47:16.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:109:0)
[18:47:16.590] Timer tick, asking Buildbucket for the build status
[18:47:16.653] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:110:0) after 1m0s
[18:48:16.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:110:0)
[18:48:16.800] Timer tick, asking Buildbucket for the build status
[18:48:16.947] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:16.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:111:0) after 1m0s
[18:49:16.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:111:0)
[18:49:16.982] Timer tick, asking Buildbucket for the build status
[18:49:17.045] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:17.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:112:0) after 1m0s
[18:50:17.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:112:0)
[18:50:17.176] Timer tick, asking Buildbucket for the build status
[18:50:17.374] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:17.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:113:0) after 1m0s
[18:51:17.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:113:0)
[18:51:17.395] Timer tick, asking Buildbucket for the build status
[18:51:17.572] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:17.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:114:0) after 1m0s
[18:52:17.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:114:0)
[18:52:17.594] Timer tick, asking Buildbucket for the build status
[18:52:17.655] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:17.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:115:0) after 1m0s
[18:53:17.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:115:0)
[18:53:17.747] Timer tick, asking Buildbucket for the build status
[18:53:17.783] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:17.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:116:0) after 1m0s
[18:54:17.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:116:0)
[18:54:17.806] Timer tick, asking Buildbucket for the build status
[18:54:17.883] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:17.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:117:0) after 1m0s
[18:55:17.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:117:0)
[18:55:17.945] Timer tick, asking Buildbucket for the build status
[18:55:18.252] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:18.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:118:0) after 1m0s
[18:56:18.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:118:0)
[18:56:18.272] Timer tick, asking Buildbucket for the build status
[18:56:18.322] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:18.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:119:0) after 1m0s
[18:57:18.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:119:0)
[18:57:18.382] Timer tick, asking Buildbucket for the build status
[18:57:18.464] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:18.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:120:0) after 1m0s
[18:58:18.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:120:0)
[18:58:18.586] Timer tick, asking Buildbucket for the build status
[18:58:18.656] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:18.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:121:0) after 1m0s
[18:59:18.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:121:0)
[18:59:18.804] Timer tick, asking Buildbucket for the build status
[18:59:19.127] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:19.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:122:0) after 1m0s
[19:00:19.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:122:0)
[19:00:19.261] Timer tick, asking Buildbucket for the build status
[19:00:19.314] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:19.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:123:0) after 1m0s
[19:01:19.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:123:0)
[19:01:19.558] Timer tick, asking Buildbucket for the build status
[19:01:19.624] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:19.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:124:0) after 1m0s
[19:02:19.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:124:0)
[19:02:19.646] Timer tick, asking Buildbucket for the build status
[19:02:19.704] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:19.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:125:0) after 1m0s
[19:03:19.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:125:0)
[19:03:19.727] Timer tick, asking Buildbucket for the build status
[19:03:19.835] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:19.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:126:0) after 1m0s
[19:04:19.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:126:0)
[19:04:19.868] Timer tick, asking Buildbucket for the build status
[19:04:19.934] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:19.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:127:0) after 1m0s
[19:05:19.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:127:0)
[19:05:19.965] Timer tick, asking Buildbucket for the build status
[19:05:20.193] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:20.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:128:0) after 1m0s
[19:06:20.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:128:0)
[19:06:20.357] Timer tick, asking Buildbucket for the build status
[19:06:20.451] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:20.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:129:0) after 1m0s
[19:07:20.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:129:0)
[19:07:20.503] Timer tick, asking Buildbucket for the build status
[19:07:20.561] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:20.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:130:0) after 1m0s
[19:08:20.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:130:0)
[19:08:20.650] Timer tick, asking Buildbucket for the build status
[19:08:20.696] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:20.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:131:0) after 1m0s
[19:09:20.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:131:0)
[19:09:20.869] Timer tick, asking Buildbucket for the build status
[19:09:20.928] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:132:0) after 1m0s
[19:10:20.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:132:0)
[19:10:20.950] Timer tick, asking Buildbucket for the build status
[19:10:20.996] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:133:0) after 1m0s
[19:11:21.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:133:0)
[19:11:21.019] Timer tick, asking Buildbucket for the build status
[19:11:21.074] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:134:0) after 1m0s
[19:12:21.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:134:0)
[19:12:21.108] Timer tick, asking Buildbucket for the build status
[19:12:21.164] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:21.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:135:0) after 1m0s
[19:13:21.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:135:0)
[19:13:21.277] Timer tick, asking Buildbucket for the build status
[19:13:21.402] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:21.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:136:0) after 1m0s
[19:14:21.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:136:0)
[19:14:21.533] Timer tick, asking Buildbucket for the build status
[19:14:21.604] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:21.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:137:0) after 1m0s
[19:15:21.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:137:0)
[19:15:21.654] Timer tick, asking Buildbucket for the build status
[19:15:21.728] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:21.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:138:0) after 1m0s
[19:16:21.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:138:0)
[19:16:21.851] Timer tick, asking Buildbucket for the build status
[19:16:22.079] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:22.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:139:0) after 1m0s
[19:17:22.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:139:0)
[19:17:22.217] Timer tick, asking Buildbucket for the build status
[19:17:22.330] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:22.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:140:0) after 1m0s
[19:18:22.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:140:0)
[19:18:22.361] Timer tick, asking Buildbucket for the build status
[19:18:22.447] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:22.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:141:0) after 1m0s
[19:19:22.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:141:0)
[19:19:22.590] Timer tick, asking Buildbucket for the build status
[19:19:22.657] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:22.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:142:0) after 1m0s
[19:20:22.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:142:0)
[19:20:22.742] Timer tick, asking Buildbucket for the build status
[19:20:22.795] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:22.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:143:0) after 1m0s
[19:21:22.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:143:0)
[19:21:22.938] Timer tick, asking Buildbucket for the build status
[19:21:23.027] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:23.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:144:0) after 1m0s
[19:22:23.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:144:0)
[19:22:23.173] Timer tick, asking Buildbucket for the build status
[19:22:23.209] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:23.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:145:0) after 1m0s
[19:23:23.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:145:0)
[19:23:23.320] Timer tick, asking Buildbucket for the build status
[19:23:23.440] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:23.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:146:0) after 1m0s
[19:24:23.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:146:0)
[19:24:23.514] Timer tick, asking Buildbucket for the build status
[19:24:23.590] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:147:0) after 1m0s
[19:25:23.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:147:0)
[19:25:23.731] Timer tick, asking Buildbucket for the build status
[19:25:24.072] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:24.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:148:0) after 1m0s
[19:26:24.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:148:0)
[19:26:24.233] Timer tick, asking Buildbucket for the build status
[19:26:24.421] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:24.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:149:0) after 1m0s
[19:27:24.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:149:0)
[19:27:24.455] Timer tick, asking Buildbucket for the build status
[19:27:24.509] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:24.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:150:0) after 1m0s
[19:28:24.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:150:0)
[19:28:24.531] Timer tick, asking Buildbucket for the build status
[19:28:24.581] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:24.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:151:0) after 1m0s
[19:29:24.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:151:0)
[19:29:24.649] Timer tick, asking Buildbucket for the build status
[19:29:24.784] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:24.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:152:0) after 1m0s
[19:30:24.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:152:0)
[19:30:24.809] Timer tick, asking Buildbucket for the build status
[19:30:24.862] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:24.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:153:0) after 1m0s
[19:31:24.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:153:0)
[19:31:24.894] Timer tick, asking Buildbucket for the build status
[19:31:24.975] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:24.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:154:0) after 1m0s
[19:32:25.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:154:0)
[19:32:25.064] Timer tick, asking Buildbucket for the build status
[19:32:25.196] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:25.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:155:0) after 1m0s
[19:33:25.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:155:0)
[19:33:25.227] Timer tick, asking Buildbucket for the build status
[19:33:25.330] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:25.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:156:0) after 1m0s
[19:34:25.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:156:0)
[19:34:25.423] Timer tick, asking Buildbucket for the build status
[19:34:25.484] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:25.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:157:0) after 1m0s
[19:35:25.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:157:0)
[19:35:25.515] Timer tick, asking Buildbucket for the build status
[19:35:25.578] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:158:0) after 1m0s
[19:36:25.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:158:0)
[19:36:25.600] Timer tick, asking Buildbucket for the build status
[19:36:25.664] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:25.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:159:0) after 1m0s
[19:37:25.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:159:0)
[19:37:25.684] Timer tick, asking Buildbucket for the build status
[19:37:25.867] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:25.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:160:0) after 1m0s
[19:38:25.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:160:0)
[19:38:25.897] Timer tick, asking Buildbucket for the build status
[19:38:26.017] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:26.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:161:0) after 1m0s
[19:39:26.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:161:0)
[19:39:26.056] Timer tick, asking Buildbucket for the build status
[19:39:26.124] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:26.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:162:0) after 1m0s
[19:40:26.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:162:0)
[19:40:26.150] Timer tick, asking Buildbucket for the build status
[19:40:26.223] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:26.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:163:0) after 1m0s
[19:41:26.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:163:0)
[19:41:26.250] Timer tick, asking Buildbucket for the build status
[19:41:26.318] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:26.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:164:0) after 1m0s
[19:42:26.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:164:0)
[19:42:26.439] Timer tick, asking Buildbucket for the build status
[19:42:26.491] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:165:0) after 1m0s
[19:43:26.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:165:0)
[19:43:26.668] Timer tick, asking Buildbucket for the build status
[19:43:26.890] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:26.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:166:0) after 1m0s
[19:44:26.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:166:0)
[19:44:26.924] Timer tick, asking Buildbucket for the build status
[19:44:27.055] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:27.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:167:0) after 1m0s
[19:45:27.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:167:0)
[19:45:27.139] Timer tick, asking Buildbucket for the build status
[19:45:27.240] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:27.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:168:0) after 1m0s
[19:46:27.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:168:0)
[19:46:27.334] Timer tick, asking Buildbucket for the build status
[19:46:28.474] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:28.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:169:0) after 1m0s
[19:47:28.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:169:0)
[19:47:28.510] Timer tick, asking Buildbucket for the build status
[19:47:28.883] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:28.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:170:0) after 1m0s
[19:48:28.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:170:0)
[19:48:28.913] Timer tick, asking Buildbucket for the build status
[19:48:29.031] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:29.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:171:0) after 1m0s
[19:49:29.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:171:0)
[19:49:29.057] Timer tick, asking Buildbucket for the build status
[19:49:29.136] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:172:0) after 1m0s
[19:50:29.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:172:0)
[19:50:29.176] Timer tick, asking Buildbucket for the build status
[19:50:29.241] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:29.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:173:0) after 1m0s
[19:51:29.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:173:0)
[19:51:29.266] Timer tick, asking Buildbucket for the build status
[19:51:29.377] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:29.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:174:0) after 1m0s
[19:52:29.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:174:0)
[19:52:29.457] Timer tick, asking Buildbucket for the build status
[19:52:29.526] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:29.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:175:0) after 1m0s
[19:53:29.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:175:0)
[19:53:29.558] Timer tick, asking Buildbucket for the build status
[19:53:29.619] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:29.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:176:0) after 1m0s
[19:54:29.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:176:0)
[19:54:29.648] Timer tick, asking Buildbucket for the build status
[19:54:29.880] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:177:0) after 1m0s
[19:55:29.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:177:0)
[19:55:29.914] Timer tick, asking Buildbucket for the build status
[19:55:30.251] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:178:0) after 1m0s
[19:56:30.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:178:0)
[19:56:30.288] Timer tick, asking Buildbucket for the build status
[19:56:30.445] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:30.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:179:0) after 1m0s
[19:57:30.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:179:0)
[19:57:30.471] Timer tick, asking Buildbucket for the build status
[19:57:30.599] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:180:0) after 1m0s
[19:58:30.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:180:0)
[19:58:30.642] Timer tick, asking Buildbucket for the build status
[19:58:30.838] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:30.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:181:0) after 1m0s
[19:59:30.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:181:0)
[19:59:30.883] Timer tick, asking Buildbucket for the build status
[19:59:30.991] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:30.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:182:0) after 1m0s
[20:00:31.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:182:0)
[20:00:31.154] Timer tick, asking Buildbucket for the build status
[20:00:31.588] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:31.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:183:0) after 1m0s
[20:01:31.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:183:0)
[20:01:31.612] Timer tick, asking Buildbucket for the build status
[20:01:31.845] Build 8943453850114085712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:31.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108883913985593616:184:0) after 1m0s
[20:01:53.813] Received PubSub notification, asking Buildbucket for the build status
[20:01:53.866] Build 8943453850114085712: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[20:01:53.866] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1529265712644436",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1529254785389147",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8943453850114085712",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe177065bdb13e403f8a15c8e3bcdebffb4dd17c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"task_result\": {\"run_id\": \"3e2781bceeb86c11\", \"created_ts\": \"2018-06-17T16:59:46.171869\", \"try_number\": \"1\", \"bot_version\": \"a05add8da0279746f7894db2d776781bf284a02fe59235097cc09761bd9a0330\", \"task_id\": \"3e2781bceeb86c10\", \"internal_failure\": true, \"current_task_slice\": \"0\", \"bot_dimensions\": [{\"value\": [\"Windows deterministic\"], \"key\": \"builder\"}, {\"value\": [\"git\", \"goma_v2\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm2173-c4\"], \"key\": \"id\"}, {\"value\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"key\": \"image\"}, {\"value\": [\"high\"], \"key\": \"integrity\"}, {\"value\": [\"en_US.cp1252\"], \"key\": \"locale\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"key\": \"os\"}, {\"value\": [\"luci.chromium.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3649-5aeacfe\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"server_versions\": [\"3649-5aeacfe\"], \"state\": \"BOT_DIED\", \"name\": \"bb-8943453850114085712-chromium-Windows deterministic\", \"abandoned_ts\": \"2018-06-17T20:01:52.644436\", \"failure\": false, \"costs_usd\": [2.2091677374128817], \"modified_ts\": \"2018-06-17T20:01:52.644436\", \"user\": \"\", \"started_ts\": \"2018-06-17T17:00:21.604294\", \"tags\": [\"build_address:luci.chromium.ci/Windows deterministic/54\", \"buildbucket_bucket:luci.chromium.ci\", \"buildbucket_build_id:8943453850114085712\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864\", \"builder:Windows deterministic\", \"buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c\", \"cores:8\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943453850114085712/+/annotations\", \"luci_project:chromium\", \"os:Windows-10\", \"pool:luci.chromium.ci\", \"priority:60\", \"recipe_name:swarming/deterministic_build\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9108883913985593616\", \"scheduler_job_id:chromium/Windows deterministic\", \"service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"swarming.pool.template:skip\", \"swarming.pool.version:7b1b5d239a2e04e83d3627884ca58c970e37b2b0\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"bot_id\": \"swarm2173-c4\"}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1529254821604294",
"status": "COMPLETED",
"status_changed_ts": "1529265713053264",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/54",
"builder:Windows deterministic",
"buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9108883913985593616",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"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/54",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943453850114085712",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe177065bdb13e403f8a15c8e3bcdebffb4dd17c",
"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/8943453850114085712/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"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:9108883913985593616",
"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:7b1b5d239a2e04e83d3627884ca58c970e37b2b0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e2781bceeb86c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1529265713053971",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/54",
"utcnow_ts": "1529265713849830"
}
}
[20:01:53.866] Invocation finished in 3h2m11.552333705s with status FAILED