[16:04:20.210] New invocation is queued and will start shortly
[16:04:21.377] Starting the invocation (attempt 1)
[16:04:21.405] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:04:21.406] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:04:21.406] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097834567578710160",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097834567578710160",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"gitiles_ref:refs/heads/master"
]
}
[16:04:26.047] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539792261551625",
"id": "8932404505509814688",
"lease_expiration_ts": "1539936265549411",
"lease_key": "1717340807",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1539792265928419",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10433",
"builder:Windows deterministic",
"buildset:commit/git/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097834567578710160",
"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/10433",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932404505509814688",
"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/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"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/8932404505509814688/+/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:9097834567578710160",
"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:82431e273d2f347205266ff4363205d6de25e0ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:409b96e4a80b6810",
"user_agent:luci-scheduler"
],
"updated_ts": "1539792265928511",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10433",
"utcnow_ts": "1539792266026157"
}
}
[16:04:26.047] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10433
[16:04:26.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:2:0) after 1m0s
[16:05:26.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:2:0)
[16:05:26.064] Timer tick, asking Buildbucket for the build status
[16:05:26.226] Build 8932404505509814688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:26.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:3:0) after 1m0s
[16:06:21.532] Received PubSub notification, asking Buildbucket for the build status
[16:06:21.572] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:26.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:3:0)
[16:06:26.251] Timer tick, asking Buildbucket for the build status
[16:06:26.308] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:26.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:5:0) after 1m0s
[16:07:26.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:5:0)
[16:07:26.327] Timer tick, asking Buildbucket for the build status
[16:07:26.373] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:26.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:6:0) after 1m0s
[16:08:26.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:6:0)
[16:08:26.389] Timer tick, asking Buildbucket for the build status
[16:08:26.433] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:26.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:7:0) after 1m0s
[16:09:26.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:7:0)
[16:09:26.465] Timer tick, asking Buildbucket for the build status
[16:09:26.584] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:26.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:8:0) after 1m0s
[16:10:26.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:8:0)
[16:10:26.645] Timer tick, asking Buildbucket for the build status
[16:10:26.755] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:26.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:9:0) after 1m0s
[16:11:26.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:9:0)
[16:11:26.772] Timer tick, asking Buildbucket for the build status
[16:11:26.831] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:26.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:10:0) after 1m0s
[16:12:26.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:10:0)
[16:12:26.849] Timer tick, asking Buildbucket for the build status
[16:12:26.890] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:26.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:11:0) after 1m0s
[16:13:26.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:11:0)
[16:13:26.911] Timer tick, asking Buildbucket for the build status
[16:13:26.999] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:26.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:12:0) after 1m0s
[16:14:27.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:12:0)
[16:14:27.017] Timer tick, asking Buildbucket for the build status
[16:14:27.062] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:27.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:13:0) after 1m0s
[16:15:27.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:13:0)
[16:15:27.087] Timer tick, asking Buildbucket for the build status
[16:15:27.304] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:27.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:14:0) after 1m0s
[16:16:27.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:14:0)
[16:16:27.322] Timer tick, asking Buildbucket for the build status
[16:16:27.454] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:27.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:15:0) after 1m0s
[16:17:27.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:15:0)
[16:17:27.476] Timer tick, asking Buildbucket for the build status
[16:17:27.783] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:27.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:16:0) after 1m0s
[16:18:27.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:16:0)
[16:18:27.803] Timer tick, asking Buildbucket for the build status
[16:18:27.903] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:27.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:17:0) after 1m0s
[16:19:27.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:17:0)
[16:19:27.923] Timer tick, asking Buildbucket for the build status
[16:19:27.988] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:27.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:18:0) after 1m0s
[16:20:28.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:18:0)
[16:20:28.015] Timer tick, asking Buildbucket for the build status
[16:20:28.159] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:28.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:19:0) after 1m0s
[16:21:28.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:19:0)
[16:21:28.210] Timer tick, asking Buildbucket for the build status
[16:21:28.425] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:28.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:20:0) after 1m0s
[16:22:28.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:20:0)
[16:22:28.546] Timer tick, asking Buildbucket for the build status
[16:22:28.676] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:28.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:21:0) after 1m0s
[16:23:28.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:21:0)
[16:23:28.731] Timer tick, asking Buildbucket for the build status
[16:23:28.814] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:28.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:22:0) after 1m0s
[16:24:28.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:22:0)
[16:24:28.833] Timer tick, asking Buildbucket for the build status
[16:24:28.908] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:28.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:23:0) after 1m0s
[16:25:28.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:23:0)
[16:25:28.938] Timer tick, asking Buildbucket for the build status
[16:25:29.060] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:29.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:24:0) after 1m0s
[16:26:29.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:24:0)
[16:26:29.087] Timer tick, asking Buildbucket for the build status
[16:26:29.129] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:29.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:25:0) after 1m0s
[16:27:29.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:25:0)
[16:27:29.153] Timer tick, asking Buildbucket for the build status
[16:27:29.209] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:26:0) after 1m0s
[16:28:29.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:26:0)
[16:28:29.236] Timer tick, asking Buildbucket for the build status
[16:28:29.305] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:29.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:27:0) after 1m0s
[16:29:29.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:27:0)
[16:29:29.322] Timer tick, asking Buildbucket for the build status
[16:29:29.523] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:29.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:28:0) after 1m0s
[16:30:29.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:28:0)
[16:30:29.541] Timer tick, asking Buildbucket for the build status
[16:30:29.590] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:29.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:29:0) after 1m0s
[16:31:29.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:29:0)
[16:31:29.616] Timer tick, asking Buildbucket for the build status
[16:31:29.720] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:29.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:30:0) after 1m0s
[16:32:29.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:30:0)
[16:32:29.755] Timer tick, asking Buildbucket for the build status
[16:32:29.859] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:29.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:31:0) after 1m0s
[16:33:29.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:31:0)
[16:33:29.913] Timer tick, asking Buildbucket for the build status
[16:33:30.049] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:30.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:32:0) after 1m0s
[16:34:30.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:32:0)
[16:34:30.076] Timer tick, asking Buildbucket for the build status
[16:34:30.109] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:30.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:33:0) after 1m0s
[16:35:30.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:33:0)
[16:35:30.131] Timer tick, asking Buildbucket for the build status
[16:35:30.197] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:30.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:34:0) after 1m0s
[16:36:30.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:34:0)
[16:36:30.237] Timer tick, asking Buildbucket for the build status
[16:36:30.290] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:30.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:35:0) after 1m0s
[16:37:30.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:35:0)
[16:37:30.310] Timer tick, asking Buildbucket for the build status
[16:37:30.473] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:30.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:36:0) after 1m0s
[16:38:30.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:36:0)
[16:38:30.520] Timer tick, asking Buildbucket for the build status
[16:38:30.595] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:37:0) after 1m0s
[16:39:30.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:37:0)
[16:39:30.627] Timer tick, asking Buildbucket for the build status
[16:39:30.724] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:30.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:38:0) after 1m0s
[16:40:30.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:38:0)
[16:40:30.741] Timer tick, asking Buildbucket for the build status
[16:40:30.924] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:30.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:39:0) after 1m0s
[16:41:30.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:39:0)
[16:41:30.955] Timer tick, asking Buildbucket for the build status
[16:41:31.026] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:31.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:40:0) after 1m0s
[16:42:31.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:40:0)
[16:42:31.081] Timer tick, asking Buildbucket for the build status
[16:42:31.149] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:31.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:41:0) after 1m0s
[16:43:31.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:41:0)
[16:43:31.206] Timer tick, asking Buildbucket for the build status
[16:43:31.333] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:31.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:42:0) after 1m0s
[16:44:31.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:42:0)
[16:44:31.368] Timer tick, asking Buildbucket for the build status
[16:44:31.447] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:31.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:43:0) after 1m0s
[16:45:31.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:43:0)
[16:45:31.482] Timer tick, asking Buildbucket for the build status
[16:45:31.518] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:31.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:44:0) after 1m0s
[16:46:31.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:44:0)
[16:46:31.543] Timer tick, asking Buildbucket for the build status
[16:46:31.600] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:31.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:45:0) after 1m0s
[16:47:31.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:45:0)
[16:47:31.619] Timer tick, asking Buildbucket for the build status
[16:47:31.685] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:31.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:46:0) after 1m0s
[16:48:31.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:46:0)
[16:48:31.805] Timer tick, asking Buildbucket for the build status
[16:48:31.863] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:31.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:47:0) after 1m0s
[16:49:31.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:47:0)
[16:49:31.996] Timer tick, asking Buildbucket for the build status
[16:49:32.313] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:48:0) after 1m0s
[16:50:32.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:48:0)
[16:50:32.337] Timer tick, asking Buildbucket for the build status
[16:50:32.637] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:32.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:49:0) after 1m0s
[16:51:32.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:49:0)
[16:51:32.664] Timer tick, asking Buildbucket for the build status
[16:51:32.893] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:32.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:50:0) after 1m0s
[16:52:32.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:50:0)
[16:52:32.921] Timer tick, asking Buildbucket for the build status
[16:52:32.961] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:51:0) after 1m0s
[16:53:33.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:51:0)
[16:53:33.042] Timer tick, asking Buildbucket for the build status
[16:53:33.211] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:33.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:52:0) after 1m0s
[16:54:33.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:52:0)
[16:54:33.232] Timer tick, asking Buildbucket for the build status
[16:54:33.273] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:33.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:53:0) after 1m0s
[16:55:33.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:53:0)
[16:55:33.307] Timer tick, asking Buildbucket for the build status
[16:55:33.724] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:33.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:54:0) after 1m0s
[16:56:33.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:54:0)
[16:56:33.753] Timer tick, asking Buildbucket for the build status
[16:56:33.799] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:33.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:55:0) after 1m0s
[16:57:33.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:55:0)
[16:57:33.828] Timer tick, asking Buildbucket for the build status
[16:57:33.898] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:33.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:56:0) after 1m0s
[16:58:33.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:56:0)
[16:58:33.920] Timer tick, asking Buildbucket for the build status
[16:58:33.995] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:33.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:57:0) after 1m0s
[16:59:34.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:57:0)
[16:59:34.148] Timer tick, asking Buildbucket for the build status
[16:59:34.276] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:34.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:58:0) after 1m0s
[17:00:34.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:58:0)
[17:00:34.354] Timer tick, asking Buildbucket for the build status
[17:00:34.436] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:34.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:59:0) after 1m0s
[17:01:34.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:59:0)
[17:01:34.470] Timer tick, asking Buildbucket for the build status
[17:01:34.614] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:34.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:60:0) after 1m0s
[17:02:34.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:60:0)
[17:02:34.650] Timer tick, asking Buildbucket for the build status
[17:02:34.692] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:34.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:61:0) after 1m0s
[17:03:34.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:61:0)
[17:03:34.735] Timer tick, asking Buildbucket for the build status
[17:03:34.797] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:34.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:62:0) after 1m0s
[17:04:34.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:62:0)
[17:04:34.898] Timer tick, asking Buildbucket for the build status
[17:04:34.939] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:34.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:63:0) after 1m0s
[17:05:34.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:63:0)
[17:05:34.970] Timer tick, asking Buildbucket for the build status
[17:05:35.034] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:64:0) after 1m0s
[17:06:35.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:64:0)
[17:06:35.144] Timer tick, asking Buildbucket for the build status
[17:06:35.232] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:35.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:65:0) after 1m0s
[17:07:35.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:65:0)
[17:07:35.277] Timer tick, asking Buildbucket for the build status
[17:07:35.376] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:35.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:66:0) after 1m0s
[17:08:35.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:66:0)
[17:08:35.397] Timer tick, asking Buildbucket for the build status
[17:08:35.472] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:35.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:67:0) after 1m0s
[17:09:35.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:67:0)
[17:09:35.765] Timer tick, asking Buildbucket for the build status
[17:09:35.847] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:35.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:68:0) after 1m0s
[17:10:35.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:68:0)
[17:10:35.881] Timer tick, asking Buildbucket for the build status
[17:10:35.982] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:35.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:69:0) after 1m0s
[17:11:36.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:69:0)
[17:11:36.011] Timer tick, asking Buildbucket for the build status
[17:11:36.049] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:36.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:70:0) after 1m0s
[17:12:36.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:70:0)
[17:12:36.092] Timer tick, asking Buildbucket for the build status
[17:12:36.168] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:36.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:71:0) after 1m0s
[17:13:36.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:71:0)
[17:13:36.241] Timer tick, asking Buildbucket for the build status
[17:13:36.312] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:36.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:72:0) after 1m0s
[17:14:36.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:72:0)
[17:14:36.341] Timer tick, asking Buildbucket for the build status
[17:14:36.516] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:36.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:73:0) after 1m0s
[17:15:36.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:73:0)
[17:15:36.562] Timer tick, asking Buildbucket for the build status
[17:15:36.616] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:36.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:74:0) after 1m0s
[17:16:36.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:74:0)
[17:16:36.648] Timer tick, asking Buildbucket for the build status
[17:16:36.695] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:36.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:75:0) after 1m0s
[17:17:36.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:75:0)
[17:17:36.725] Timer tick, asking Buildbucket for the build status
[17:17:36.774] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:36.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:76:0) after 1m0s
[17:18:36.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:76:0)
[17:18:36.812] Timer tick, asking Buildbucket for the build status
[17:18:36.902] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:36.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:77:0) after 1m0s
[17:19:36.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:77:0)
[17:19:36.941] Timer tick, asking Buildbucket for the build status
[17:19:36.998] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:36.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:78:0) after 1m0s
[17:20:37.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:78:0)
[17:20:37.021] Timer tick, asking Buildbucket for the build status
[17:20:37.098] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:37.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:79:0) after 1m0s
[17:21:37.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:79:0)
[17:21:37.118] Timer tick, asking Buildbucket for the build status
[17:21:37.162] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:37.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:80:0) after 1m0s
[17:22:37.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:80:0)
[17:22:37.190] Timer tick, asking Buildbucket for the build status
[17:22:37.261] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:37.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:81:0) after 1m0s
[17:23:37.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:81:0)
[17:23:37.294] Timer tick, asking Buildbucket for the build status
[17:23:37.336] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:37.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:82:0) after 1m0s
[17:24:37.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:82:0)
[17:24:37.359] Timer tick, asking Buildbucket for the build status
[17:24:37.446] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:37.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:83:0) after 1m0s
[17:25:37.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:83:0)
[17:25:37.473] Timer tick, asking Buildbucket for the build status
[17:25:37.661] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:37.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:84:0) after 1m0s
[17:26:37.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:84:0)
[17:26:37.691] Timer tick, asking Buildbucket for the build status
[17:26:37.739] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:85:0) after 1m0s
[17:27:37.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:85:0)
[17:27:37.771] Timer tick, asking Buildbucket for the build status
[17:27:37.808] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:37.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:86:0) after 1m0s
[17:28:37.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:86:0)
[17:28:37.839] Timer tick, asking Buildbucket for the build status
[17:28:37.956] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:37.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:87:0) after 1m0s
[17:29:37.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:87:0)
[17:29:37.980] Timer tick, asking Buildbucket for the build status
[17:29:38.026] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:38.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:88:0) after 1m0s
[17:30:38.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:88:0)
[17:30:38.194] Timer tick, asking Buildbucket for the build status
[17:30:38.232] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:38.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:89:0) after 1m0s
[17:31:38.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:89:0)
[17:31:38.269] Timer tick, asking Buildbucket for the build status
[17:31:38.430] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:38.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:90:0) after 1m0s
[17:32:38.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:90:0)
[17:32:38.452] Timer tick, asking Buildbucket for the build status
[17:32:38.510] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:38.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:91:0) after 1m0s
[17:33:38.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:91:0)
[17:33:38.532] Timer tick, asking Buildbucket for the build status
[17:33:38.594] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:38.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:92:0) after 1m0s
[17:34:38.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:92:0)
[17:34:38.620] Timer tick, asking Buildbucket for the build status
[17:34:38.690] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:38.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:93:0) after 1m0s
[17:35:38.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:93:0)
[17:35:38.721] Timer tick, asking Buildbucket for the build status
[17:35:38.764] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:38.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:94:0) after 1m0s
[17:36:38.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:94:0)
[17:36:38.793] Timer tick, asking Buildbucket for the build status
[17:36:38.871] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:38.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:95:0) after 1m0s
[17:37:38.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:95:0)
[17:37:38.908] Timer tick, asking Buildbucket for the build status
[17:37:38.958] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:38.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:96:0) after 1m0s
[17:38:39.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:96:0)
[17:38:39.045] Timer tick, asking Buildbucket for the build status
[17:38:39.193] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:39.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:97:0) after 1m0s
[17:39:39.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:97:0)
[17:39:39.276] Timer tick, asking Buildbucket for the build status
[17:39:39.789] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:39.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:98:0) after 1m0s
[17:40:39.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:98:0)
[17:40:39.825] Timer tick, asking Buildbucket for the build status
[17:40:39.904] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:39.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:99:0) after 1m0s
[17:41:39.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:99:0)
[17:41:39.929] Timer tick, asking Buildbucket for the build status
[17:41:39.992] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:39.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:100:0) after 1m0s
[17:42:40.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:100:0)
[17:42:40.014] Timer tick, asking Buildbucket for the build status
[17:42:40.080] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:40.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:101:0) after 1m0s
[17:43:40.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:101:0)
[17:43:40.144] Timer tick, asking Buildbucket for the build status
[17:43:40.205] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:102:0) after 1m0s
[17:44:40.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:102:0)
[17:44:40.289] Timer tick, asking Buildbucket for the build status
[17:44:40.344] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:40.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:103:0) after 1m0s
[17:45:40.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:103:0)
[17:45:40.387] Timer tick, asking Buildbucket for the build status
[17:45:40.478] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:40.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:104:0) after 1m0s
[17:46:40.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:104:0)
[17:46:40.501] Timer tick, asking Buildbucket for the build status
[17:46:40.643] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:40.643] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:105:0) after 1m0s
[17:47:40.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:105:0)
[17:47:40.671] Timer tick, asking Buildbucket for the build status
[17:47:40.711] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:40.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:106:0) after 1m0s
[17:48:40.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:106:0)
[17:48:40.748] Timer tick, asking Buildbucket for the build status
[17:48:40.815] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:40.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:107:0) after 1m0s
[17:49:40.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:107:0)
[17:49:40.856] Timer tick, asking Buildbucket for the build status
[17:49:41.235] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:41.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:108:0) after 1m0s
[17:50:41.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:108:0)
[17:50:41.265] Timer tick, asking Buildbucket for the build status
[17:50:41.321] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:41.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:109:0) after 1m0s
[17:51:41.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:109:0)
[17:51:41.352] Timer tick, asking Buildbucket for the build status
[17:51:41.413] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:41.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:110:0) after 1m0s
[17:52:41.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:110:0)
[17:52:41.491] Timer tick, asking Buildbucket for the build status
[17:52:41.538] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:41.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:111:0) after 1m0s
[17:53:41.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:111:0)
[17:53:41.584] Timer tick, asking Buildbucket for the build status
[17:53:41.663] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:112:0) after 1m0s
[17:54:41.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:112:0)
[17:54:41.691] Timer tick, asking Buildbucket for the build status
[17:54:41.767] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:41.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:113:0) after 1m0s
[17:55:41.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:113:0)
[17:55:41.866] Timer tick, asking Buildbucket for the build status
[17:55:41.911] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:41.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:114:0) after 1m0s
[17:56:42.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:114:0)
[17:56:42.048] Timer tick, asking Buildbucket for the build status
[17:56:42.125] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:115:0) after 1m0s
[17:57:42.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:115:0)
[17:57:42.152] Timer tick, asking Buildbucket for the build status
[17:57:42.258] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:42.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:116:0) after 1m0s
[17:58:42.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:116:0)
[17:58:42.452] Timer tick, asking Buildbucket for the build status
[17:58:42.510] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:42.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:117:0) after 1m0s
[17:59:42.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:117:0)
[17:59:42.550] Timer tick, asking Buildbucket for the build status
[17:59:42.624] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:42.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:118:0) after 1m0s
[18:00:42.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:118:0)
[18:00:42.685] Timer tick, asking Buildbucket for the build status
[18:00:42.717] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:42.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:119:0) after 1m0s
[18:01:42.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:119:0)
[18:01:42.747] Timer tick, asking Buildbucket for the build status
[18:01:42.917] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:42.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:120:0) after 1m0s
[18:02:43.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:120:0)
[18:02:43.031] Timer tick, asking Buildbucket for the build status
[18:02:43.114] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:43.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:121:0) after 1m0s
[18:03:43.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:121:0)
[18:03:43.157] Timer tick, asking Buildbucket for the build status
[18:03:43.217] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:43.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:122:0) after 1m0s
[18:04:43.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:122:0)
[18:04:43.245] Timer tick, asking Buildbucket for the build status
[18:04:43.442] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:43.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:123:0) after 1m0s
[18:05:43.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:123:0)
[18:05:43.473] Timer tick, asking Buildbucket for the build status
[18:05:43.546] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:43.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:124:0) after 1m0s
[18:06:43.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:124:0)
[18:06:43.570] Timer tick, asking Buildbucket for the build status
[18:06:43.807] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:43.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:125:0) after 1m0s
[18:07:43.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:125:0)
[18:07:43.918] Timer tick, asking Buildbucket for the build status
[18:07:43.960] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:126:0) after 1m0s
[18:08:43.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:126:0)
[18:08:43.991] Timer tick, asking Buildbucket for the build status
[18:08:44.029] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:44.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:127:0) after 1m0s
[18:09:44.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:127:0)
[18:09:44.129] Timer tick, asking Buildbucket for the build status
[18:09:44.268] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:44.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:128:0) after 1m0s
[18:10:44.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:128:0)
[18:10:44.299] Timer tick, asking Buildbucket for the build status
[18:10:44.337] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:44.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:129:0) after 1m0s
[18:11:44.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:129:0)
[18:11:44.369] Timer tick, asking Buildbucket for the build status
[18:11:44.555] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:44.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:130:0) after 1m0s
[18:12:44.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:130:0)
[18:12:44.719] Timer tick, asking Buildbucket for the build status
[18:12:44.844] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:44.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:131:0) after 1m0s
[18:13:44.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:131:0)
[18:13:44.870] Timer tick, asking Buildbucket for the build status
[18:13:44.929] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:44.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:132:0) after 1m0s
[18:14:44.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:132:0)
[18:14:44.980] Timer tick, asking Buildbucket for the build status
[18:14:45.370] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:45.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:133:0) after 1m0s
[18:15:45.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:133:0)
[18:15:45.407] Timer tick, asking Buildbucket for the build status
[18:15:45.639] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:45.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:134:0) after 1m0s
[18:16:45.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:134:0)
[18:16:45.670] Timer tick, asking Buildbucket for the build status
[18:16:45.723] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:45.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:135:0) after 1m0s
[18:17:45.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:135:0)
[18:17:45.782] Timer tick, asking Buildbucket for the build status
[18:17:45.829] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:45.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:136:0) after 1m0s
[18:18:45.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:136:0)
[18:18:45.861] Timer tick, asking Buildbucket for the build status
[18:18:45.899] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:45.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:137:0) after 1m0s
[18:19:45.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:137:0)
[18:19:45.921] Timer tick, asking Buildbucket for the build status
[18:19:46.145] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:46.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:138:0) after 1m0s
[18:20:46.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:138:0)
[18:20:46.189] Timer tick, asking Buildbucket for the build status
[18:20:46.249] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:46.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:139:0) after 1m0s
[18:21:46.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:139:0)
[18:21:46.286] Timer tick, asking Buildbucket for the build status
[18:21:46.544] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:46.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:140:0) after 1m0s
[18:22:46.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:140:0)
[18:22:46.570] Timer tick, asking Buildbucket for the build status
[18:22:46.615] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:46.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:141:0) after 1m0s
[18:23:46.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:141:0)
[18:23:46.657] Timer tick, asking Buildbucket for the build status
[18:23:46.744] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:46.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:142:0) after 1m0s
[18:24:46.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:142:0)
[18:24:46.783] Timer tick, asking Buildbucket for the build status
[18:24:46.842] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:46.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:143:0) after 1m0s
[18:25:46.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:143:0)
[18:25:46.889] Timer tick, asking Buildbucket for the build status
[18:25:46.948] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:46.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:144:0) after 1m0s
[18:26:46.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:144:0)
[18:26:46.983] Timer tick, asking Buildbucket for the build status
[18:26:47.159] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:47.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:145:0) after 1m0s
[18:27:47.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:145:0)
[18:27:47.202] Timer tick, asking Buildbucket for the build status
[18:27:47.244] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:47.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:146:0) after 1m0s
[18:28:47.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:146:0)
[18:28:47.284] Timer tick, asking Buildbucket for the build status
[18:28:47.537] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:47.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:147:0) after 1m0s
[18:29:47.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:147:0)
[18:29:47.579] Timer tick, asking Buildbucket for the build status
[18:29:47.618] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:47.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:148:0) after 1m0s
[18:30:47.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:148:0)
[18:30:47.725] Timer tick, asking Buildbucket for the build status
[18:30:47.811] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:47.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:149:0) after 1m0s
[18:31:47.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:149:0)
[18:31:47.844] Timer tick, asking Buildbucket for the build status
[18:31:47.884] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:47.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:150:0) after 1m0s
[18:32:47.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:150:0)
[18:32:47.910] Timer tick, asking Buildbucket for the build status
[18:32:48.140] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:48.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:151:0) after 1m0s
[18:33:48.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:151:0)
[18:33:48.169] Timer tick, asking Buildbucket for the build status
[18:33:48.214] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:48.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:152:0) after 1m0s
[18:34:48.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:152:0)
[18:34:48.248] Timer tick, asking Buildbucket for the build status
[18:34:48.407] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:48.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:153:0) after 1m0s
[18:35:48.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:153:0)
[18:35:48.454] Timer tick, asking Buildbucket for the build status
[18:35:48.504] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:48.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:154:0) after 1m0s
[18:36:48.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:154:0)
[18:36:48.569] Timer tick, asking Buildbucket for the build status
[18:36:48.646] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:48.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:155:0) after 1m0s
[18:37:48.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:155:0)
[18:37:48.672] Timer tick, asking Buildbucket for the build status
[18:37:48.757] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:48.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:156:0) after 1m0s
[18:38:48.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:156:0)
[18:38:48.813] Timer tick, asking Buildbucket for the build status
[18:38:48.933] Build 8932404505509814688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:48.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097834567578710160:157:0) after 1m0s
[18:39:19.149] Received PubSub notification, asking Buildbucket for the build status
[18:39:19.185] Build 8932404505509814688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:39:19.185] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1539801557843189",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539792261551625",
"id": "8932404505509814688",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\"}}",
"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/8932404505509814688/+/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\": [\"3809-a31bbe1\"], \"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\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25228}\", \"$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@{#600408}\", \"branch\": \"refs/heads/master\", \"revision\": \"ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"5a464d3ee56ac2acc1c08a351f68f78e51bac144\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"1d8a783c9db2b7ab999933447f015d7acae42639\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1539792261551625, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097834567578710160\", \"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\": \"8932404505509814688\"}}, \"got_v8_revision\": \"db22e96fb4501f1da2415dac90d728cbfeb94981\", \"got_v8_revision_cp\": \"refs/heads/7.2.31@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10433, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"58493ee8381654214d47033cea124665f3e6e56c\", \"notification_helper_unittests\": \"40ca312f8ed4004fd9ea6b4a2eef83d092f02e39\", \"gpu_perftests\": \"06d42aa663a4e2d2c96319e8ed58e31543b90710\", \"vr_common_unittests\": \"d68e60f0dbd640fc87ebbb1f60960bd83380b98e\", \"telemetry_unittests\": \"ed8f291d1e967304b0f1d615d744ed1bc4f8e9dc\", \"load_library_perf_tests\": \"a22c2b9693921bf5704e2a1247d9e224503beabc\", \"devtools_closure_compile\": \"e5fdb60f3d0b809f5dba004aa4fc6811a9563518\", \"chromedriver_py_tests\": \"6675a14845ef07a86b529f007b1091a179bce694\", \"mojo_core_unittests\": \"8977d0a59732addb5c50ac1b9bc8306ff83df26c\", \"install_static_unittests\": \"a197181900201a63f5d98a4eccdbb7bbf239da7a\", \"leveldb_service_unittests\": \"73f41d0ae2a05526deafcfdb9b90f13bd2fd0c06\", \"mini_installer_tests\": \"12acc1dbb599fce7aba053f32f08bd0326b9e3d1\", \"gcp_unittests\": \"0d368f79b1753ff793ec6f1b4f245223643b21b7\", \"sbox_integration_tests\": \"0965c9b3d4f08e911f6ac9124664a9a06f56d513\", \"angle_unittests\": \"ffd1a886a4ee0defef5e149cfaeed865bc62a35d\", \"cast_unittests\": \"e3cee5e6b010c4be6892d0d9618a4b563d0e6ff2\", \"cc_unittests\": \"f37412c4b1e20c439dddee08d948a0e413032888\", \"blink_common_unittests\": \"302534cfa0e1ff8e5066436c99e0e5cb26be0cd4\", \"crashpad_tests\": \"eaf33fb447032006cf07109c38feeef66540b5df\", \"telemetry_perf_tests_without_chrome\": \"8e79f1940d0c14ea5c2e5321c7851c1ba3ec7510\", \"metrics_python_tests\": \"4c930335e2678a6a02b5e65d3d2fef74a583a459\", \"message_center_unittests\": \"d5d9c6deb70c67a62401eb999e8f13dc6344ca6c\", \"ppapi_unittests\": \"cefa01500a5293a395a4ab2bdbb4398824678c17\", \"extensions_unittests\": \"b7073f574fdb630a351777dd1334e8ad88aa633c\", \"gl_unittests_ozone\": \"51c150ee0131d1cc7ace61f4bcf928476d78e143\", \"app_shell_unittests\": \"e7391dc708c3ad0ab2e5c7bc6d549a5d4e02f2cf\", \"chrome_app_unittests\": \"6697247b51f81b26914211bdd06a49bf685aab21\", \"gl_unittests\": \"51c150ee0131d1cc7ace61f4bcf928476d78e143\", \"gcm_unit_tests\": \"8df704dba855d89b785427ca9c44e82f0cbbda6c\", \"views_unittests\": \"aea79d49ca8505b410f6a031f907e2ebfaf6c3b8\", \"content_shell_crash_test\": \"836795b8bbf92015aba4b74e4431d1ec14c31eff\", \"ui_base_unittests\": \"6d9924ae4ca63cd25e53033d7a9acd69a07761e2\", \"cronet_unittests\": \"9a8ecefca6205cc35e9698205e2e95da448376ee\", \"performance_test_suite\": \"b2692c596c6994bc5af40a0336336a971164d161\", \"wm_unittests\": \"9a61ed647a80ece6c49e6099e3dc850bb8453587\", \"boringssl_crypto_tests\": \"0f2c65f800b814695e3fd627e3c2bcc3738ca273\", \"gin_unittests\": \"e54d5550f2e955b816efe58772ed9781c5d9c5d2\", \"performance_browser_tests\": \"7aef01f900adb718505d6ea9de9a3a55c8d19659\", \"extensions_browsertests\": \"f22a7ce2836892142dc47f0981e17a75522177f7\", \"webkit_python_tests\": \"27230a36d722fe4325ce9291e9a5d1708d4067fc\", \"headless_unittests\": \"f4bf090515901475275c548ccf370d7ca3eae4b3\", \"webkit_layout_tests\": \"6fac049b437a798b7d3023a305774a2fc820405e\", \"vr_pixeltests\": \"de5ec2474010648a8ff03467177d4779063b0b2c\", \"setup_unittests\": \"bbfe6f562ce030f77c4a08d1a03eea3ae5c5070b\", \"webkit_unit_tests\": \"2a6c52340ff534001855e2f497e51238a1ddf9fe\", \"content_unittests\": \"3b930090f538fcd88f3de3485587890189a1560e\", \"performance_webview_test_suite\": \"7475ba92af31abf07d02dbdbf25adf53068d0f4c\", \"wtf_unittests\": \"61ffc94e6382a31bfbb460fbcd4830749e23147a\", \"webkit_layout_tests_exparchive\": \"cb649e7256ff65be849ddf0a1f3d049ecc37b2c1\", \"chrome_cleaner_unittests\": \"e4d3b6fb8ebbb22719a58c34b8f528f0e76ed602\", \"traffic_annotation_auditor_unittests\": \"703c5f717d29c8e4d6798575a94760001bb5e529\", \"libjingle_xmpp_unittests\": \"6d3ae87f482f8598dd942b559af80221bba15724\", \"remoting_unittests\": \"d644e57bd3b3fcd928e41829559e89539ccb905f\", \"vr_common_perftests\": \"7182f1d4674063a25d1115a6a1e4d910ad8ef590\", \"filesystem_service_unittests\": \"11ffe2331abba8578761fec0529c32890c72286b\", \"chrome_elf_import_unittests\": \"58bdc9fcb38db2e8852cb54f888ade9e419fe3ab\", \"installer_util_unittests\": \"bf934377809d41003c4a9dfd5b7fac9b71c4f1df\", \"gfx_unittests\": \"8040dcf599719e75a35bee265a492f1d6dbffdd4\", \"headless_browsertests\": \"61868713ce67f7387aefc4f6c43b8466dcc8709c\", \"capture_unittests\": \"64f6527f0b09a22c0bf048740b73bf663f0c82b9\", \"chrome_elf_unittests\": \"610ce48f5c04331ebcb42bc866aae0748adc8735\", \"telemetry_gpu_unittests\": \"c1bae4093533844be0cb66b090bbeaa3167fbdae\", \"command_buffer_perftests\": \"79d80e971255d1b1a5106b4d835f4a2e44792c8e\", \"media_unittests\": \"d6c22130f55be7929b0b22435e7af5e9e4e0b444\", \"chromedriver_unittests\": \"0a9d2538190df923689d8e503e8d8f197cf40073\", \"views_mus_interactive_ui_tests\": \"be833aa47dac379ab46c244321a5474b0793cba3\", \"storage_unittests\": \"4ba92ef66edd8cef634d48d147e2e987c0725ced\", \"media_service_unittests\": \"cc443ac7f21596583f09361daaaa9c982abb7a56\", \"compositor_unittests\": \"0011d77fdfce48f1e02052f734f2bc2ce7449c3b\", \"latency_unittests\": \"0ec812f4e229551d66efed2c2927d1127c8db34c\", \"video_decode_accelerator_unittest\": \"c8aadfe9dcf16d07c15a2d402d5bed2b65707d3d\", \"swiftshader_unittests\": \"5ec93a9a54ef3b6aed0c9a49726caeeee0790db9\", \"telemetry_perf_unittests\": \"4a730d19e8255688729cb53bdc243686c15d0475\", \"media_blink_unittests\": \"1752d09d9422b3e9ba40db5398fdcea58f521084\", \"views_mus_unittests\": \"7c9ec5e93d56ca0578032753e57cd687cb0cb2db\", \"components_unittests\": \"100733a42492075192bdd37f8fce88836f9d5ed1\", \"snapshot_unittests\": \"24e20a46d46276de91a13aa207fd8408ee9c144f\", \"accessibility_unittests\": \"48b91de68d59de268f4ae6ca84299be0451cd43b\", \"net_perftests\": \"67b5ff57b5b3c446496b74b51b574b9905cbc358\", \"aura_unittests\": \"702257df7162c9f0edb5177c1c6a303090a697c9\", \"services_unittests\": \"53702a3aa2914a18bb8fdcc4ade9151b0250da0b\", \"components_perftests\": \"86049adbb427d0da5232a825edd208f2f295d8ed\", \"events_unittests\": \"77d695e90f748b033fa568376cbd92cb73d8f569\", \"tracing_perftests\": \"1b8ef3a48ef1e4cad73d76b30c642416e36397b4\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"17e52874c8504d67abd3800b715ab7c1f5e7b9b8\", \"cacheinvalidation_unittests\": \"e9d4ba3f161875aff2b4c3a6722a74486c8bda13\", \"viz_unittests\": \"cacf5f20445c1cb9de3cb9fc50c06406862bbd98\", \"browser_tests\": \"38aa53154e122e254658f7bc4b67b9316a7c8db1\", \"net_unittests\": \"e6f97a87c1aefd036e54a6fb09686f68e8ad3315\", \"pdf_unittests\": \"a9596de70dfd5ec34cfa0549c9fe0a27f83d3002\", \"boringssl_ssl_tests\": \"9c310e520c55ea0f85809143c208207539e417e4\", \"sbox_validation_tests\": \"2e834a74f96099e2cbc6c11fbc91eb2032ad0b56\", \"elevation_service_unittests\": \"46c860c779b273af8572dcf5772add900a0e70cf\", \"gpu_unittests\": \"997310e6dfee1dce0aae70f68d4f98686a291bf7\", \"native_theme_unittests\": \"6fb6331d0c9338c995498049ba928023d5672a90\", \"interactive_ui_tests\": \"aba93c7240ad47a873d2b6848ec8b1236ee681ea\", \"mojo_unittests\": \"266a57e957a1e8a93d77809c168efe460992dc50\", \"url_unittests\": \"ad51c9fab0056e235226df52bf6c32968334c886\", \"media_perftests\": \"9b347fc817b6f00b71a19bc3b10e47def839fd30\", \"cronet_tests\": \"59ccc1172c2f73e1eed95918c54b10d08f440c59\", \"google_apis_unittests\": \"ef238502c016b4ba610938dc15500d4851ea00ca\", \"telemetry_gpu_integration_test\": \"975f37e27c8797d784b5cdcf5784bec7defc9b15\", \"blink_heap_unittests\": \"624795e986025a601fab02a3d6ad66b12b57d374\", \"midi_unittests\": \"682e78e8c1bd07d701378dc15c3e3854886cfd0b\", \"base_unittests\": \"cba308fd9c0dfa041111165d52583ccd638f13dc\", \"sync_integration_tests\": \"658bbcce25e2a68f57c2a83a6864cc7be4dae064\", \"sql_unittests\": \"574b926b06e19ad3c69f6b61644dc787808d92c2\", \"courgette_unittests\": \"3fc39199d3331daf7dd4bde5ba1d838c4858e4d6\", \"blink_fuzzer_unittests\": \"bd244eec2102b5beb79cc3ca045f8710eca03c80\", \"gl_tests\": \"16b852832a7cb3a3867e3c57db62b15047a5fdf1\", \"zucchini_unittests\": \"a0e8f966d4abcadd735c7acf3a93ced185586288\", \"ipc_tests\": \"b2d9f752048bd8aba0b3ba9b6c6cd23fb44faf99\", \"angle_end2end_tests\": \"bb7e7c56ce338ce938493e8e0047109b21c2b602\", \"blink_platform_unittests\": \"763c63e64a1c0e6a44acaeda9930cf44611ca732\", \"components_browsertests\": \"53f7e38d303004598ea3bcae11d60235ea018514\", \"views_perftests\": \"c668d4dcb40f0e297cb20902b016bd58de370b0e\", \"angle_perftests\": \"e306240ab910e65d049d3a91a0d0068527ab0a26\", \"display_unittests\": \"0af54bc67a0db6d321c37f3db7badb40ff97cc17\", \"sbox_unittests\": \"863258bd08d4b5653e772c745d77bdde1196b6d0\", \"service_manager_unittests\": \"bc335c045bb0575b936f2b8046f5dd53b68de20c\", \"gles2_conform_test\": \"386f714c093838aec7624acaa86faedc4f4e73d2\", \"jingle_unittests\": \"d7e28e196f3eee04fb5e6625b3dec15dc973284e\", \"skia_unittests\": \"9f7bb16567f866ea8f435659d208c3da0f65569f\", \"angle_white_box_tests\": \"b68040f2a114c0cb77e03089fb820db2cff8acf2\", \"crypto_unittests\": \"905ede32645f6d85db0fba5fac5d46373f677fd6\", \"nacl_loader_unittests\": \"d6e76e876c579ae269a2103654e36b12d05c8887\", \"unit_tests\": \"eebba9583f3f497a834acbfba3b19ed76e4eee23\", \"content_browsertests\": \"e1bdd16b9c08e5c71ba8178e0ae1c5839a33d64b\", \"printing_unittests\": \"9cf7b7d82f82ade2c022ce32c0dc7798322d3ff3\", \"device_unittests\": \"269ac96eb3d9a42f39dcb929ce24acc99f6facfd\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1539792380320472",
"status": "COMPLETED",
"status_changed_ts": "1539801558476501",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10433",
"builder:Windows deterministic",
"buildset:commit/git/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097834567578710160",
"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/10433",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932404505509814688",
"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/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac77d3be9db2aba1c1ee14b7cefa400b6bfdc0e0",
"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/8932404505509814688/+/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:9097834567578710160",
"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:82431e273d2f347205266ff4363205d6de25e0ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:409b96e4a80b6810",
"user_agent:luci-scheduler"
],
"updated_ts": "1539801558478816",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10433",
"utcnow_ts": "1539801559175021"
}
}
[18:39:19.185] Invocation finished in 2h34m58.99062725s with status SUCCEEDED