[14:17:50.593] New invocation is queued and will start shortly
[14:17:51.780] Starting the invocation (attempt 1)
[14:17:51.823] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:17:51.823] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:17:51.823] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9094670373778673840",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9094670373778673840",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"gitiles_ref:refs/heads/master"
]
}
[14:17:53.822] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542809871891003",
"id": "8929240311730293136",
"lease_expiration_ts": "1542928673568686",
"lease_key": "422535222",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1542809873698505",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10786",
"builder:Windows deterministic",
"buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9094670373778673840",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/10786",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8929240311730293136",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:996803d2171388bf48e777ec1d601168944508b8",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8929240311730293136/+/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:9094670373778673840",
"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:84c8acbcf4a7c1b932f13e81204f2368c38b4c08",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:414f73f27692da10",
"user_agent:luci-scheduler"
],
"updated_ts": "1542809873698613",
"url": "https://ci.chromium.org/b/8929240311730293136",
"utcnow_ts": "1542809873811682"
}
}
[14:17:53.823] Task URL: https://ci.chromium.org/b/8929240311730293136
[14:17:53.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:2:0) after 1m0s
[14:17:55.106] Received PubSub notification, asking Buildbucket for the build status
[14:17:55.167] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:2:0)
[14:18:53.847] Timer tick, asking Buildbucket for the build status
[14:18:53.932] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:4:0) after 1m0s
[14:19:53.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:4:0)
[14:19:53.950] Timer tick, asking Buildbucket for the build status
[14:19:54.074] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:54.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:5:0) after 1m0s
[14:20:54.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:5:0)
[14:20:54.093] Timer tick, asking Buildbucket for the build status
[14:20:54.178] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:54.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:6:0) after 1m0s
[14:21:54.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:6:0)
[14:21:54.226] Timer tick, asking Buildbucket for the build status
[14:21:54.448] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:54.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:7:0) after 1m0s
[14:22:54.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:7:0)
[14:22:54.523] Timer tick, asking Buildbucket for the build status
[14:22:54.663] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:54.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:8:0) after 1m0s
[14:23:54.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:8:0)
[14:23:54.683] Timer tick, asking Buildbucket for the build status
[14:23:54.842] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:54.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:9:0) after 1m0s
[14:24:54.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:9:0)
[14:24:54.864] Timer tick, asking Buildbucket for the build status
[14:24:54.928] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:54.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:10:0) after 1m0s
[14:25:54.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:10:0)
[14:25:54.954] Timer tick, asking Buildbucket for the build status
[14:25:54.987] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:54.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:11:0) after 1m0s
[14:26:55.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:11:0)
[14:26:55.018] Timer tick, asking Buildbucket for the build status
[14:26:55.066] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:55.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:12:0) after 1m0s
[14:27:55.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:12:0)
[14:27:55.113] Timer tick, asking Buildbucket for the build status
[14:27:55.182] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:55.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:13:0) after 1m0s
[14:28:55.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:13:0)
[14:28:55.206] Timer tick, asking Buildbucket for the build status
[14:28:55.280] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:55.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:14:0) after 1m0s
[14:29:55.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:14:0)
[14:29:55.312] Timer tick, asking Buildbucket for the build status
[14:29:55.428] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:55.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:15:0) after 1m0s
[14:30:55.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:15:0)
[14:30:55.448] Timer tick, asking Buildbucket for the build status
[14:30:55.605] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:55.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:16:0) after 1m0s
[14:31:55.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:16:0)
[14:31:55.648] Timer tick, asking Buildbucket for the build status
[14:31:55.758] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:17:0) after 1m0s
[14:32:55.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:17:0)
[14:32:55.823] Timer tick, asking Buildbucket for the build status
[14:32:55.871] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:55.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:18:0) after 1m0s
[14:33:55.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:18:0)
[14:33:55.892] Timer tick, asking Buildbucket for the build status
[14:33:56.012] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:56.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:19:0) after 1m0s
[14:34:56.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:19:0)
[14:34:56.101] Timer tick, asking Buildbucket for the build status
[14:34:56.153] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:56.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:20:0) after 1m0s
[14:35:56.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:20:0)
[14:35:56.173] Timer tick, asking Buildbucket for the build status
[14:35:56.238] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:56.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:21:0) after 1m0s
[14:36:56.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:21:0)
[14:36:56.272] Timer tick, asking Buildbucket for the build status
[14:36:56.455] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:56.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:22:0) after 1m0s
[14:37:56.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:22:0)
[14:37:56.477] Timer tick, asking Buildbucket for the build status
[14:37:56.548] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:56.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:23:0) after 1m0s
[14:38:56.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:23:0)
[14:38:56.573] Timer tick, asking Buildbucket for the build status
[14:38:56.632] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:56.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:24:0) after 1m0s
[14:39:56.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:24:0)
[14:39:56.657] Timer tick, asking Buildbucket for the build status
[14:39:56.744] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:56.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:25:0) after 1m0s
[14:40:56.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:25:0)
[14:40:56.770] Timer tick, asking Buildbucket for the build status
[14:40:56.872] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:56.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:26:0) after 1m0s
[14:41:56.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:26:0)
[14:41:56.896] Timer tick, asking Buildbucket for the build status
[14:41:56.962] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:27:0) after 1m0s
[14:42:56.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:27:0)
[14:42:56.981] Timer tick, asking Buildbucket for the build status
[14:42:57.043] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:57.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:28:0) after 1m0s
[14:43:57.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:28:0)
[14:43:57.064] Timer tick, asking Buildbucket for the build status
[14:43:57.151] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:57.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:29:0) after 1m0s
[14:44:57.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:29:0)
[14:44:57.173] Timer tick, asking Buildbucket for the build status
[14:44:57.444] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:57.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:30:0) after 1m0s
[14:45:57.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:30:0)
[14:45:57.484] Timer tick, asking Buildbucket for the build status
[14:45:57.551] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:57.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:31:0) after 1m0s
[14:46:57.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:31:0)
[14:46:57.572] Timer tick, asking Buildbucket for the build status
[14:46:57.670] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:57.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:32:0) after 1m0s
[14:47:57.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:32:0)
[14:47:57.778] Timer tick, asking Buildbucket for the build status
[14:47:57.834] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:57.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:33:0) after 1m0s
[14:48:57.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:33:0)
[14:48:57.862] Timer tick, asking Buildbucket for the build status
[14:48:57.982] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:57.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:34:0) after 1m0s
[14:49:58.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:34:0)
[14:49:58.017] Timer tick, asking Buildbucket for the build status
[14:49:58.128] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:58.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:35:0) after 1m0s
[14:50:58.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:35:0)
[14:50:58.157] Timer tick, asking Buildbucket for the build status
[14:50:58.226] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:36:0) after 1m0s
[14:51:58.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:36:0)
[14:51:58.299] Timer tick, asking Buildbucket for the build status
[14:51:58.494] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:58.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:37:0) after 1m0s
[14:52:58.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:37:0)
[14:52:58.518] Timer tick, asking Buildbucket for the build status
[14:52:58.556] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:58.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:38:0) after 1m0s
[14:53:58.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:38:0)
[14:53:58.659] Timer tick, asking Buildbucket for the build status
[14:53:58.737] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:58.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:39:0) after 1m0s
[14:54:58.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:39:0)
[14:54:58.769] Timer tick, asking Buildbucket for the build status
[14:54:58.864] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:58.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:40:0) after 1m0s
[14:55:58.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:40:0)
[14:55:58.981] Timer tick, asking Buildbucket for the build status
[14:55:59.122] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:59.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:41:0) after 1m0s
[14:56:59.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:41:0)
[14:56:59.144] Timer tick, asking Buildbucket for the build status
[14:56:59.240] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:59.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:42:0) after 1m0s
[14:57:59.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:42:0)
[14:57:59.332] Timer tick, asking Buildbucket for the build status
[14:57:59.389] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:59.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:43:0) after 1m0s
[14:58:59.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:43:0)
[14:58:59.418] Timer tick, asking Buildbucket for the build status
[14:58:59.523] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:59.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:44:0) after 1m0s
[14:59:59.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:44:0)
[14:59:59.550] Timer tick, asking Buildbucket for the build status
[14:59:59.620] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:59.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:45:0) after 1m0s
[15:00:59.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:45:0)
[15:00:59.646] Timer tick, asking Buildbucket for the build status
[15:00:59.831] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:59.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:46:0) after 1m0s
[15:01:59.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:46:0)
[15:01:59.926] Timer tick, asking Buildbucket for the build status
[15:01:59.967] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:59.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:47:0) after 1m0s
[15:02:59.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:47:0)
[15:02:59.991] Timer tick, asking Buildbucket for the build status
[15:03:00.056] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:00.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:48:0) after 1m0s
[15:04:00.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:48:0)
[15:04:00.081] Timer tick, asking Buildbucket for the build status
[15:04:00.159] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:00.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:49:0) after 1m0s
[15:05:00.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:49:0)
[15:05:00.196] Timer tick, asking Buildbucket for the build status
[15:05:00.257] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:00.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:50:0) after 1m0s
[15:06:00.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:50:0)
[15:06:00.280] Timer tick, asking Buildbucket for the build status
[15:06:00.324] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:00.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:51:0) after 1m0s
[15:07:00.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:51:0)
[15:07:00.367] Timer tick, asking Buildbucket for the build status
[15:07:00.417] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:00.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:52:0) after 1m0s
[15:08:00.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:52:0)
[15:08:00.443] Timer tick, asking Buildbucket for the build status
[15:08:00.573] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:00.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:53:0) after 1m0s
[15:09:00.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:53:0)
[15:09:00.596] Timer tick, asking Buildbucket for the build status
[15:09:00.702] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:00.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:54:0) after 1m0s
[15:10:00.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:54:0)
[15:10:00.731] Timer tick, asking Buildbucket for the build status
[15:10:00.806] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:00.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:55:0) after 1m0s
[15:11:00.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:55:0)
[15:11:00.831] Timer tick, asking Buildbucket for the build status
[15:11:00.891] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:00.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:56:0) after 1m0s
[15:12:00.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:56:0)
[15:12:00.917] Timer tick, asking Buildbucket for the build status
[15:12:01.076] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:01.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:57:0) after 1m0s
[15:13:01.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:57:0)
[15:13:01.153] Timer tick, asking Buildbucket for the build status
[15:13:01.266] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:01.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:58:0) after 1m0s
[15:14:01.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:58:0)
[15:14:01.297] Timer tick, asking Buildbucket for the build status
[15:14:01.336] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:01.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:59:0) after 1m0s
[15:15:01.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:59:0)
[15:15:01.363] Timer tick, asking Buildbucket for the build status
[15:15:01.448] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:01.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:60:0) after 1m0s
[15:16:01.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:60:0)
[15:16:01.470] Timer tick, asking Buildbucket for the build status
[15:16:01.583] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:01.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:61:0) after 1m0s
[15:17:01.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:61:0)
[15:17:01.605] Timer tick, asking Buildbucket for the build status
[15:17:01.683] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:01.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:62:0) after 1m0s
[15:18:01.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:62:0)
[15:18:01.710] Timer tick, asking Buildbucket for the build status
[15:18:01.749] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:01.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:63:0) after 1m0s
[15:19:01.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:63:0)
[15:19:01.784] Timer tick, asking Buildbucket for the build status
[15:19:01.854] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:01.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:64:0) after 1m0s
[15:20:01.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:64:0)
[15:20:01.925] Timer tick, asking Buildbucket for the build status
[15:20:02.036] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:02.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:65:0) after 1m0s
[15:21:02.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:65:0)
[15:21:02.178] Timer tick, asking Buildbucket for the build status
[15:21:02.345] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:02.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:66:0) after 1m0s
[15:22:02.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:66:0)
[15:22:02.499] Timer tick, asking Buildbucket for the build status
[15:22:02.588] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:02.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:67:0) after 1m0s
[15:23:02.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:67:0)
[15:23:02.613] Timer tick, asking Buildbucket for the build status
[15:23:02.658] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:02.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:68:0) after 1m0s
[15:24:02.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:68:0)
[15:24:02.682] Timer tick, asking Buildbucket for the build status
[15:24:02.806] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:02.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:69:0) after 1m0s
[15:25:02.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:69:0)
[15:25:02.838] Timer tick, asking Buildbucket for the build status
[15:25:02.880] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:02.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:70:0) after 1m0s
[15:26:02.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:70:0)
[15:26:02.909] Timer tick, asking Buildbucket for the build status
[15:26:02.961] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:02.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:71:0) after 1m0s
[15:27:02.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:71:0)
[15:27:02.992] Timer tick, asking Buildbucket for the build status
[15:27:03.053] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:03.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:72:0) after 1m0s
[15:28:03.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:72:0)
[15:28:03.077] Timer tick, asking Buildbucket for the build status
[15:28:03.148] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:03.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:73:0) after 1m0s
[15:29:03.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:73:0)
[15:29:03.203] Timer tick, asking Buildbucket for the build status
[15:29:03.293] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:03.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:74:0) after 1m0s
[15:30:03.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:74:0)
[15:30:03.416] Timer tick, asking Buildbucket for the build status
[15:30:03.622] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:03.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:75:0) after 1m0s
[15:31:03.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:75:0)
[15:31:03.664] Timer tick, asking Buildbucket for the build status
[15:31:03.749] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:03.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:76:0) after 1m0s
[15:32:03.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:76:0)
[15:32:03.772] Timer tick, asking Buildbucket for the build status
[15:32:03.851] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:03.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:77:0) after 1m0s
[15:33:03.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:77:0)
[15:33:03.870] Timer tick, asking Buildbucket for the build status
[15:33:03.922] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:03.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:78:0) after 1m0s
[15:34:04.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:78:0)
[15:34:04.008] Timer tick, asking Buildbucket for the build status
[15:34:04.152] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:04.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:79:0) after 1m0s
[15:35:04.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:79:0)
[15:35:04.196] Timer tick, asking Buildbucket for the build status
[15:35:04.290] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:04.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:80:0) after 1m0s
[15:36:04.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:80:0)
[15:36:04.379] Timer tick, asking Buildbucket for the build status
[15:36:04.421] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:04.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:81:0) after 1m0s
[15:37:04.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:81:0)
[15:37:04.443] Timer tick, asking Buildbucket for the build status
[15:37:04.613] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:04.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:82:0) after 1m0s
[15:38:04.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:82:0)
[15:38:04.690] Timer tick, asking Buildbucket for the build status
[15:38:04.785] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:04.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:83:0) after 1m0s
[15:39:04.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:83:0)
[15:39:04.827] Timer tick, asking Buildbucket for the build status
[15:39:04.895] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:04.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:84:0) after 1m0s
[15:40:04.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:84:0)
[15:40:04.921] Timer tick, asking Buildbucket for the build status
[15:40:04.960] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:04.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:85:0) after 1m0s
[15:41:04.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:85:0)
[15:41:04.994] Timer tick, asking Buildbucket for the build status
[15:41:05.066] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:05.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:86:0) after 1m0s
[15:42:05.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:86:0)
[15:42:05.087] Timer tick, asking Buildbucket for the build status
[15:42:05.187] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:05.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:87:0) after 1m0s
[15:43:05.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:87:0)
[15:43:05.208] Timer tick, asking Buildbucket for the build status
[15:43:05.254] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:05.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:88:0) after 1m0s
[15:44:05.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:88:0)
[15:44:05.320] Timer tick, asking Buildbucket for the build status
[15:44:05.395] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:05.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:89:0) after 1m0s
[15:45:05.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:89:0)
[15:45:05.430] Timer tick, asking Buildbucket for the build status
[15:45:05.513] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:05.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:90:0) after 1m0s
[15:46:05.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:90:0)
[15:46:05.539] Timer tick, asking Buildbucket for the build status
[15:46:05.715] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:05.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:91:0) after 1m0s
[15:47:05.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:91:0)
[15:47:05.738] Timer tick, asking Buildbucket for the build status
[15:47:05.801] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:05.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:92:0) after 1m0s
[15:48:05.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:92:0)
[15:48:05.827] Timer tick, asking Buildbucket for the build status
[15:48:05.915] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:05.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:93:0) after 1m0s
[15:49:05.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:93:0)
[15:49:05.939] Timer tick, asking Buildbucket for the build status
[15:49:05.988] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:05.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:94:0) after 1m0s
[15:50:06.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:94:0)
[15:50:06.023] Timer tick, asking Buildbucket for the build status
[15:50:06.114] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:95:0) after 1m0s
[15:51:06.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:95:0)
[15:51:06.235] Timer tick, asking Buildbucket for the build status
[15:51:06.382] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:06.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:96:0) after 1m0s
[15:52:06.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:96:0)
[15:52:06.442] Timer tick, asking Buildbucket for the build status
[15:52:06.485] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:06.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:97:0) after 1m0s
[15:53:06.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:97:0)
[15:53:06.524] Timer tick, asking Buildbucket for the build status
[15:53:06.584] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:06.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:98:0) after 1m0s
[15:54:06.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:98:0)
[15:54:06.609] Timer tick, asking Buildbucket for the build status
[15:54:06.672] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:06.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:99:0) after 1m0s
[15:55:06.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:99:0)
[15:55:06.693] Timer tick, asking Buildbucket for the build status
[15:55:06.778] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:06.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:100:0) after 1m0s
[15:56:06.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:100:0)
[15:56:06.802] Timer tick, asking Buildbucket for the build status
[15:56:06.872] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:06.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:101:0) after 1m0s
[15:57:06.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:101:0)
[15:57:06.902] Timer tick, asking Buildbucket for the build status
[15:57:06.988] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:06.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:102:0) after 1m0s
[15:58:07.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:102:0)
[15:58:07.023] Timer tick, asking Buildbucket for the build status
[15:58:07.100] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:07.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:103:0) after 1m0s
[15:59:07.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:103:0)
[15:59:07.236] Timer tick, asking Buildbucket for the build status
[15:59:07.275] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:07.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:104:0) after 1m0s
[16:00:07.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:104:0)
[16:00:07.394] Timer tick, asking Buildbucket for the build status
[16:00:07.445] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:07.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:105:0) after 1m0s
[16:01:07.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:105:0)
[16:01:07.508] Timer tick, asking Buildbucket for the build status
[16:01:07.923] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:07.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:106:0) after 1m0s
[16:02:07.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:106:0)
[16:02:07.997] Timer tick, asking Buildbucket for the build status
[16:02:08.100] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:08.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:107:0) after 1m0s
[16:03:08.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:107:0)
[16:03:08.154] Timer tick, asking Buildbucket for the build status
[16:03:08.206] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:08.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:108:0) after 1m0s
[16:04:08.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:108:0)
[16:04:08.230] Timer tick, asking Buildbucket for the build status
[16:04:08.397] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:08.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:109:0) after 1m0s
[16:05:08.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:109:0)
[16:05:08.443] Timer tick, asking Buildbucket for the build status
[16:05:08.510] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:08.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:110:0) after 1m0s
[16:06:08.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:110:0)
[16:06:08.543] Timer tick, asking Buildbucket for the build status
[16:06:08.627] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:08.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:111:0) after 1m0s
[16:07:08.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:111:0)
[16:07:08.661] Timer tick, asking Buildbucket for the build status
[16:07:08.745] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:08.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:112:0) after 1m0s
[16:08:08.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:112:0)
[16:08:08.765] Timer tick, asking Buildbucket for the build status
[16:08:08.859] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:08.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:113:0) after 1m0s
[16:09:08.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:113:0)
[16:09:08.887] Timer tick, asking Buildbucket for the build status
[16:09:08.926] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:08.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:114:0) after 1m0s
[16:10:08.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:114:0)
[16:10:08.949] Timer tick, asking Buildbucket for the build status
[16:10:09.056] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:09.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:115:0) after 1m0s
[16:11:09.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:115:0)
[16:11:09.114] Timer tick, asking Buildbucket for the build status
[16:11:09.223] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:09.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:116:0) after 1m0s
[16:12:09.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:116:0)
[16:12:09.264] Timer tick, asking Buildbucket for the build status
[16:12:09.341] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:09.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:117:0) after 1m0s
[16:13:09.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:117:0)
[16:13:09.474] Timer tick, asking Buildbucket for the build status
[16:13:09.518] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:09.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:118:0) after 1m0s
[16:14:09.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:118:0)
[16:14:09.542] Timer tick, asking Buildbucket for the build status
[16:14:09.624] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:09.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:119:0) after 1m0s
[16:15:09.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:119:0)
[16:15:09.700] Timer tick, asking Buildbucket for the build status
[16:15:09.756] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:09.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:120:0) after 1m0s
[16:16:09.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:120:0)
[16:16:09.887] Timer tick, asking Buildbucket for the build status
[16:16:09.963] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:09.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:121:0) after 1m0s
[16:17:09.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:121:0)
[16:17:09.988] Timer tick, asking Buildbucket for the build status
[16:17:10.030] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:10.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:122:0) after 1m0s
[16:18:10.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:122:0)
[16:18:10.133] Timer tick, asking Buildbucket for the build status
[16:18:10.199] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:10.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:123:0) after 1m0s
[16:19:10.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:123:0)
[16:19:10.234] Timer tick, asking Buildbucket for the build status
[16:19:10.311] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:124:0) after 1m0s
[16:20:10.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:124:0)
[16:20:10.339] Timer tick, asking Buildbucket for the build status
[16:20:10.513] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:125:0) after 1m0s
[16:21:10.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:125:0)
[16:21:10.539] Timer tick, asking Buildbucket for the build status
[16:21:10.576] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:10.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:126:0) after 1m0s
[16:22:10.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:126:0)
[16:22:10.652] Timer tick, asking Buildbucket for the build status
[16:22:10.871] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:10.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:127:0) after 1m0s
[16:23:10.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:127:0)
[16:23:10.933] Timer tick, asking Buildbucket for the build status
[16:23:11.020] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:11.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:128:0) after 1m0s
[16:24:11.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:128:0)
[16:24:11.117] Timer tick, asking Buildbucket for the build status
[16:24:11.210] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:11.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:129:0) after 1m0s
[16:25:11.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:129:0)
[16:25:11.323] Timer tick, asking Buildbucket for the build status
[16:25:11.420] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:11.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:130:0) after 1m0s
[16:26:11.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:130:0)
[16:26:11.575] Timer tick, asking Buildbucket for the build status
[16:26:11.637] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:11.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:131:0) after 1m0s
[16:27:11.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:131:0)
[16:27:11.665] Timer tick, asking Buildbucket for the build status
[16:27:11.778] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:11.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:132:0) after 1m0s
[16:28:11.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:132:0)
[16:28:11.804] Timer tick, asking Buildbucket for the build status
[16:28:11.903] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:11.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:133:0) after 1m0s
[16:29:11.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:133:0)
[16:29:11.946] Timer tick, asking Buildbucket for the build status
[16:29:11.988] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:11.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:134:0) after 1m0s
[16:30:12.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:134:0)
[16:30:12.030] Timer tick, asking Buildbucket for the build status
[16:30:12.096] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:12.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:135:0) after 1m0s
[16:31:12.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:135:0)
[16:31:12.132] Timer tick, asking Buildbucket for the build status
[16:31:12.192] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:136:0) after 1m0s
[16:32:12.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:136:0)
[16:32:12.232] Timer tick, asking Buildbucket for the build status
[16:32:12.356] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:12.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:137:0) after 1m0s
[16:33:12.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:137:0)
[16:33:12.483] Timer tick, asking Buildbucket for the build status
[16:33:12.614] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:138:0) after 1m0s
[16:34:12.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:138:0)
[16:34:12.685] Timer tick, asking Buildbucket for the build status
[16:34:12.730] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:12.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:139:0) after 1m0s
[16:35:12.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:139:0)
[16:35:12.757] Timer tick, asking Buildbucket for the build status
[16:35:12.808] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:12.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:140:0) after 1m0s
[16:36:12.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:140:0)
[16:36:12.847] Timer tick, asking Buildbucket for the build status
[16:36:12.911] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:12.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:141:0) after 1m0s
[16:37:13.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:141:0)
[16:37:13.263] Timer tick, asking Buildbucket for the build status
[16:37:13.322] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:13.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:142:0) after 1m0s
[16:38:13.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:142:0)
[16:38:13.397] Timer tick, asking Buildbucket for the build status
[16:38:13.544] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:13.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:143:0) after 1m0s
[16:39:13.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:143:0)
[16:39:13.574] Timer tick, asking Buildbucket for the build status
[16:39:13.710] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:13.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:144:0) after 1m0s
[16:40:13.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:144:0)
[16:40:13.741] Timer tick, asking Buildbucket for the build status
[16:40:13.840] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:145:0) after 1m0s
[16:41:13.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:145:0)
[16:41:13.870] Timer tick, asking Buildbucket for the build status
[16:41:13.931] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:146:0) after 1m0s
[16:42:13.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:146:0)
[16:42:13.989] Timer tick, asking Buildbucket for the build status
[16:42:14.128] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:14.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:147:0) after 1m0s
[16:43:14.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:147:0)
[16:43:14.223] Timer tick, asking Buildbucket for the build status
[16:43:14.338] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:148:0) after 1m0s
[16:44:14.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:148:0)
[16:44:14.377] Timer tick, asking Buildbucket for the build status
[16:44:14.416] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:14.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:149:0) after 1m0s
[16:45:15.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:149:0)
[16:45:15.014] Timer tick, asking Buildbucket for the build status
[16:45:15.096] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:15.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:150:0) after 1m0s
[16:46:15.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:150:0)
[16:46:15.613] Timer tick, asking Buildbucket for the build status
[16:46:15.652] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:15.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:151:0) after 1m0s
[16:47:15.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:151:0)
[16:47:15.888] Timer tick, asking Buildbucket for the build status
[16:47:15.972] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:152:0) after 1m0s
[16:48:16.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:152:0)
[16:48:16.478] Timer tick, asking Buildbucket for the build status
[16:48:16.539] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:16.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:153:0) after 1m0s
[16:49:16.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:153:0)
[16:49:16.911] Timer tick, asking Buildbucket for the build status
[16:49:17.020] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:17.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:154:0) after 1m0s
[16:50:17.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:154:0)
[16:50:17.436] Timer tick, asking Buildbucket for the build status
[16:50:17.519] Build 8929240311730293136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:17.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094670373778673840:155:0) after 1m0s
[16:51:09.978] Received PubSub notification, asking Buildbucket for the build status
[16:51:10.061] Build 8929240311730293136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:51:10.061] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1542819068901524",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542809871891003",
"id": "8929240311730293136",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"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\": [\"3874-22d9c44\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"b6e9e23e4e79249bd4f95735205ffb7c3f9f0912\", \"got_revision\": \"c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"63997221d7d880d8d1783abe326b90cd95cd92d2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25722}\", \"$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@{#610043}\", \"branch\": \"refs/heads/master\", \"revision\": \"c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"c4d5642e136331459db922dbeb68f995d6f2411c\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"836674c28b1ec3ac1e28a4435594b5258cdd3a69\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1542809871891003, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9094670373778673840\", \"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\": \"8929240311730293136\"}}, \"got_v8_revision\": \"2ecd5f54a495900cffb0af290eb2eba39017263c\", \"got_v8_revision_cp\": \"refs/heads/7.2.391@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10786, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"50e4b7cf8e72730516190960d11a0f737d7689d7\", \"notification_helper_unittests\": \"e969ecc37177a2182f51df9260aebf993f8b3d2d\", \"gpu_perftests\": \"cf4b5c7726207e3c66e8f06e59e37c2c4ac86514\", \"vr_common_unittests\": \"13b5fda6f5659352f32dc4915903b21cdb54e45b\", \"telemetry_unittests\": \"e327a0d2cba793e486fdd16e9836dc61a64bdcda\", \"load_library_perf_tests\": \"029ac08719e3abe6df2cceb86b9c4f2687c4fc64\", \"devtools_closure_compile\": \"5e19336ca3490194e74b678a4c756286da6b6552\", \"chromedriver_py_tests\": \"753ae99934ba1cf41e170bf0db73b41ba7cc0491\", \"mojo_core_unittests\": \"a05851b56a524dc9125b4ba7f6fc8a806dba6520\", \"install_static_unittests\": \"510cdfaafab49249d9f4639e143a12bc547dc9af\", \"leveldb_service_unittests\": \"b72d2e156d006581aef74f27eeb3ce09503e6bc3\", \"mini_installer_tests\": \"394bca0d4703a3bfdb2a760a54aa4abd37924eb1\", \"gcp_unittests\": \"98a47ef3191d2eb0ff7a55d7ff928fce425c9f7e\", \"sbox_integration_tests\": \"1f96db1e16fbe97a479b619c70ed3484fe321eae\", \"angle_unittests\": \"740cc185374c92e50dcb107d8e6a2bdeab315423\", \"cast_unittests\": \"020b39e1d95095589199967318e8b54bad31a068\", \"cc_unittests\": \"463f8645cf942ba0486944f9e28c1c9e52f3a119\", \"blink_common_unittests\": \"bf055a89ccc12aa687b138f9490d6b5ceb102c6e\", \"crashpad_tests\": \"797a714f087f6bcf57f66a477776e4c599314cc8\", \"telemetry_perf_tests_without_chrome\": \"ec4607f74225a0f4c4c3770176dcff6f47fbdb65\", \"metrics_python_tests\": \"c16ec0dcde7e4d9f2dde0d7c528c94206d571f67\", \"message_center_unittests\": \"f4edd853832bb58cfa810131d9437d4d9701ac51\", \"ppapi_unittests\": \"a5e294cd10aa3af27a3ffa036b618e52471a3f62\", \"extensions_unittests\": \"81eaa374cc18348c499dd9d0665128dab05e074d\", \"gl_unittests_ozone\": \"66db6fd95eb20c98d0f82b55ad48dfee5d1cdd4a\", \"app_shell_unittests\": \"95881368d7b116700375004e45ba93041523b0c6\", \"chrome_app_unittests\": \"dc321a188393f3c4451ccd03b87302e201a6cb43\", \"gl_unittests\": \"66db6fd95eb20c98d0f82b55ad48dfee5d1cdd4a\", \"gcm_unit_tests\": \"128fee68066bfcc7f1b91aa0f25c5f49ad1df1aa\", \"views_unittests\": \"3a93749b62daaa416ef6c14b5fdaec650c83b211\", \"content_shell_crash_test\": \"081fbbf613e5f14f1a95bfe94584d68ad82d3180\", \"dawn_end2end_tests\": \"33c35efc282218942d471fb4eae78348e1951d93\", \"ui_base_unittests\": \"ef9a58b4c04e3ae5070df17e8ff0a28a089fb35c\", \"gles2_conform_test\": \"38750e90ab4706bd06e81c8f559dafc3b02ec176\", \"cronet_unittests\": \"67adea74e9f6449b45dd6054da539c5cbb2b1db3\", \"performance_test_suite\": \"1ba6a1a69d30e6bffb595d9185054636e0c6ae48\", \"wm_unittests\": \"3eab61496b77142d3e0025b71f092ef90a0e6d8d\", \"boringssl_crypto_tests\": \"f3061a6bf55abed5ef9a16381a1e05003ac159fd\", \"gin_unittests\": \"14f53af68ce5aad007a9bd456f2493bab75c24c3\", \"performance_browser_tests\": \"e3e75af13a7a649571152f18a108ee1e1d83df03\", \"extensions_browsertests\": \"77d13064c19e98cf6b241104eea80c9eca2d5647\", \"webkit_python_tests\": \"e1939d61c1194183c3dc1c534fa6744216eea8d4\", \"headless_unittests\": \"3db372ac678dcb1078ba4b092c5744b30b2b2077\", \"webkit_layout_tests\": \"d9987feff9d6043bb10a9c32640ffb40ec840bb4\", \"vr_pixeltests\": \"d32521200ad0d027b0314b6df20a6e6b893288be\", \"setup_unittests\": \"94a5b46e93928319a819b1fed35d0f575c16b50a\", \"webkit_unit_tests\": \"4a4d0de03fc4c06f8646fe5c4111cba1998d9fdd\", \"content_unittests\": \"ed83b8f30428fd5a6ec7f78a2eec02cbec1329be\", \"performance_webview_test_suite\": \"79f0b7ffffb985e7cb91cf280df88fb5b1c8ac6f\", \"wtf_unittests\": \"5ab4c161ead6da6046cca8d32bcb8dbd46b431cf\", \"webkit_layout_tests_exparchive\": \"946a3b1d5a097cbbac8321c7765704f0b4a74d8e\", \"chrome_cleaner_unittests\": \"e7820b3842f764b14f95d3db4744fb997981b392\", \"traffic_annotation_auditor_unittests\": \"4d70ce420b1f71eef1237788a882805a8b1e9939\", \"libjingle_xmpp_unittests\": \"ee55be6cfdb3c0696e60f47fd6f4674306ba18af\", \"remoting_unittests\": \"5bd150a1dd83d0c33a3f42d672f4b9183023567c\", \"vr_common_perftests\": \"056b8c85301a9b44d88dc8dd4e7582779fc97829\", \"filesystem_service_unittests\": \"b77cfa85d83c413a9780030d3d10b46cbd843f9a\", \"chrome_elf_import_unittests\": \"c94a8366acb3981d0c531368582cefe5144e4a7e\", \"installer_util_unittests\": \"fedfc56318b8f0b1cbf08a2353581f7f6bbca53c\", \"base_perftests\": \"e1d6966d0dde2d1ffe7603b25f99ef4a7bc550ff\", \"headless_browsertests\": \"851ab6b00e3e73bdfb24707d08b001817f5433d7\", \"capture_unittests\": \"97a6894fb718993e3c1a2ff574e940336a573f77\", \"chrome_elf_unittests\": \"1d745385610a1a17d02b87d8195cc01f7033c894\", \"telemetry_gpu_unittests\": \"a602e0c70383559053144b7f29fcb49e47d24f47\", \"command_buffer_perftests\": \"2791453dd4193f6e720e1fcb154f5a7187e478a6\", \"media_unittests\": \"35a9914246da681c232ea9996b47d8f7048b98b3\", \"gfx_unittests\": \"78f9637e3f727cba0df07cda96b732dbbfd9c3e4\", \"chromedriver_unittests\": \"0b66fcbffc9ab0f280b63f073c3310839dbdce3d\", \"views_mus_interactive_ui_tests\": \"97c8a978d2ac1e9064c734cf7812351e5a36b67f\", \"storage_unittests\": \"09cb0fb845e2501ef8f48ed783ecdd3e010345c5\", \"media_service_unittests\": \"8d8d7a005bd0efcf3028d65e1d8741fe46cab099\", \"compositor_unittests\": \"45bdcdd376eb311e114a81cc2b5331a3bddb44b8\", \"latency_unittests\": \"ea827b9d74a29eaba4b90640c30d86dc9679cd57\", \"video_decode_accelerator_unittest\": \"a414e11d16f9e2f24c43c6e963085eca895d7832\", \"swiftshader_unittests\": \"fe342d0dc266b8a47e9d9ba9442356b047b6cceb\", \"telemetry_perf_unittests\": \"64a56b9bfd380d1974dbe253df58bd33dce5f61e\", \"media_blink_unittests\": \"2e948be9667f46f74093c5dfa4563dea8ac3562f\", \"views_mus_unittests\": \"c5b6a4c90a62f04b44a9f751a869b8357cc5dee1\", \"components_unittests\": \"2f734c45f15ea340da26edd4c3fddf107d180ccc\", \"snapshot_unittests\": \"d140901ad89144e395aecea73d1c198e679e6d2d\", \"accessibility_unittests\": \"157221a535541fc9df542647803ff180ca1c053c\", \"net_perftests\": \"da242d16cc7bfc3dd65e214707efa69933de12b4\", \"aura_unittests\": \"9e17e9a8faf946b7c2955923228ac7a0589f2f13\", \"services_unittests\": \"60cc060e7ce4b3c29d3b7202fef88401bed59f3f\", \"components_perftests\": \"e18bacf2da054798b833026e02975a4f60a744fc\", \"events_unittests\": \"e8fee05ef32219c735e8aa9f0f8033aba40b0022\", \"tracing_perftests\": \"f6340f86df2599ef93a2ba9401b5a11a83f7e743\", \"chromedriver_replay_unittests\": \"4bd1faf821fce24d79157820b7b7cd3ac2473ff6\", \"ui_touch_selection_unittests\": \"796f80c8d3307a50bd186e77b51e7cbb83657358\", \"cacheinvalidation_unittests\": \"93d9aa36f42faa8bd1214fbdda7f71440ece8791\", \"viz_unittests\": \"c66cbb46f339ffdec9aa969eaf31e5ff1ace38f1\", \"browser_tests\": \"e63bf5024a0db2755cb44c6803d9fe2c1e89f21b\", \"net_unittests\": \"54478c566535e1c5aa6e914cbf90c2b0d07fc51c\", \"midi_unittests\": \"6b6eadbac23ac00464527af2b24511d8faf7470f\", \"boringssl_ssl_tests\": \"638cf03d79dc69313ebd8d828ba4cf9676366d87\", \"sbox_validation_tests\": \"98409ccca905e06080e1c0412e2184d40d2644f5\", \"elevation_service_unittests\": \"f07ea3f2597685df8077cb9f30717f9ea9eb761f\", \"gpu_unittests\": \"30449dcdac7e3ce26fb364d01a81246520d06efc\", \"native_theme_unittests\": \"b987edccf244396c79370928cdbb0f6e1cff56e8\", \"interactive_ui_tests\": \"8ade12e9a3b2dfc6a93d44794dfc027695d78d33\", \"mojo_unittests\": \"62857010d42e0a4f6fa582d30bd701382f79a7cd\", \"url_unittests\": \"c84ea59b466288b17e370f16b92f42ed29c75085\", \"media_perftests\": \"85735550df7c522eaf56cfb72fb368868c122a41\", \"cronet_tests\": \"946fc554b0afddc45383e498b1226d30e0eb21da\", \"google_apis_unittests\": \"29bccea60d7aa44a1bd80f0a34c8193fb10f6034\", \"telemetry_gpu_integration_test\": \"f81d4ef5997a550fcabcdba2cb696bc41acd7e15\", \"blink_heap_unittests\": \"b1291e9ae6db8126eda6ad5b6f42c4abc36d8c25\", \"base_unittests\": \"2b440e91474ee2cdfcaeb7c50dc7cca59cb81b2f\", \"sync_integration_tests\": \"338bafa6cb2672a2520d33e5c1d0161d46105b90\", \"sql_unittests\": \"4de5db27cba2edc0e85fe80356f50b3d23c55634\", \"courgette_unittests\": \"052f110a8e4588e10de7518e49ee6dac6521d83f\", \"blink_fuzzer_unittests\": \"8e117c839080a81f6c41fb06f49a1ad9cb5bc8d1\", \"gl_tests\": \"9d356c64eab3acde0c80705e8f6799a138ad1213\", \"zucchini_unittests\": \"3c924209fd1e6b1ba087b18b6cd661421ceb6a1b\", \"ipc_tests\": \"acbc6c1d498cd14c14631fcfe38600a2c80fea7b\", \"pdf_unittests\": \"bcaf1b3edbba9a5b06bcf0356d7df69678c79bd7\", \"blink_platform_unittests\": \"5171a790f5b798883613aa78beef8ddc681a6a92\", \"components_browsertests\": \"2e83187f0d000913a9ab2e9ace450cd241eba5dd\", \"views_perftests\": \"712476b263fa71b47f516ad7b4ff3530e9827bd5\", \"angle_perftests\": \"e8d4e47819279041462c629137e0095a49e8852b\", \"display_unittests\": \"e1ea84bad047e443899dbe80758f18bd089bfbe9\", \"sbox_unittests\": \"6b6aa1af9c023731dfe29e99099117713ac7e4c1\", \"service_manager_unittests\": \"4913d2f9d880665732c90e6cd2d656c111c31a28\", \"angle_end2end_tests\": \"f72eb3c4bca3be6dcd5f9331c4f4920574e0031c\", \"jingle_unittests\": \"a54201960b9e115d191c052acf1769ad5e726092\", \"skia_unittests\": \"6f694f4282316cba9bf7071dfe7d298db041acf9\", \"angle_white_box_tests\": \"ebf8c1d722aadddd477867758d886644f37d13ee\", \"crypto_unittests\": \"a2010a97aa131464d65e85cd94167a6a6e29a3a4\", \"nacl_loader_unittests\": \"6ea81bf960401bced5ed6856bb9d97c3c797b442\", \"unit_tests\": \"9c158ad918086e93b8f1a211d09e4f7e47c9a626\", \"content_browsertests\": \"a8ecc2018313d8b9441c8e932de38f0288fcb037\", \"printing_unittests\": \"8af6c0b5db7b132f19a1942a78a78ac0cf54cea7\", \"device_unittests\": \"a21b3665345d529d10641b3245df749ef318ae38\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"da9b2941cbf6d6d67b694e069e8e8dc06910f66a\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1542809874459198",
"status": "COMPLETED",
"status_changed_ts": "1542819069584718",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10786",
"builder:Windows deterministic",
"buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9094670373778673840",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/10786",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8929240311730293136",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:996803d2171388bf48e777ec1d601168944508b8",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c33c50f3aa4a1bc6d007373a8da33e95f911bd4c",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8929240311730293136/+/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:9094670373778673840",
"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:84c8acbcf4a7c1b932f13e81204f2368c38b4c08",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:414f73f27692da10",
"user_agent:luci-scheduler"
],
"updated_ts": "1542819069586460",
"url": "https://ci.chromium.org/b/8929240311730293136",
"utcnow_ts": "1542819070027933"
}
}
[16:51:10.061] Invocation finished in 2h33m19.507410472s with status SUCCEEDED