[00:01:38.208] New invocation is queued and will start shortly
[00:01:39.518] Starting the invocation (attempt 1)
[00:01:39.560] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:01:39.560] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:01:39.560] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9101247223183770704",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e173abbe12395f96f27fd79fd476ac6ee0891f92\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9101247223183770704",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"gitiles_ref:refs/heads/master"
]
}
[00:01:41.405] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536537699680849",
"id": "8935817160978146720",
"lease_expiration_ts": "1536681700832414",
"lease_key": "1582867442",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e173abbe12395f96f27fd79fd476ac6ee0891f92\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536537701178936",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10033",
"builder:Windows deterministic",
"buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101247223183770704",
"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/10033",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935817160978146720",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"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/8935817160978146720/+/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:9101247223183770704",
"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:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fd99a3057e5d810",
"user_agent:luci-scheduler"
],
"updated_ts": "1536537701179139",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10033",
"utcnow_ts": "1536537701358409"
}
}
[00:01:41.406] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10033
[00:01:41.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:2:0) after 1m0s
[00:01:42.270] Received PubSub notification, asking Buildbucket for the build status
[00:01:42.443] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:41.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:2:0)
[00:02:41.420] Timer tick, asking Buildbucket for the build status
[00:02:41.505] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:41.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:4:0) after 1m0s
[00:03:41.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:4:0)
[00:03:41.556] Timer tick, asking Buildbucket for the build status
[00:03:41.613] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:41.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:5:0) after 1m0s
[00:04:41.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:5:0)
[00:04:41.632] Timer tick, asking Buildbucket for the build status
[00:04:41.691] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:41.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:6:0) after 1m0s
[00:05:41.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:6:0)
[00:05:41.766] Timer tick, asking Buildbucket for the build status
[00:05:41.836] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:41.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:7:0) after 1m0s
[00:06:42.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:7:0)
[00:06:42.038] Timer tick, asking Buildbucket for the build status
[00:06:42.087] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:42.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:8:0) after 1m0s
[00:07:42.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:8:0)
[00:07:42.104] Timer tick, asking Buildbucket for the build status
[00:07:42.250] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:42.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:9:0) after 1m0s
[00:08:42.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:9:0)
[00:08:42.398] Timer tick, asking Buildbucket for the build status
[00:08:42.604] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:42.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:10:0) after 1m0s
[00:09:42.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:10:0)
[00:09:42.631] Timer tick, asking Buildbucket for the build status
[00:09:42.737] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:11:0) after 1m0s
[00:10:42.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:11:0)
[00:10:42.754] Timer tick, asking Buildbucket for the build status
[00:10:42.820] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:42.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:12:0) after 1m0s
[00:11:42.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:12:0)
[00:11:42.837] Timer tick, asking Buildbucket for the build status
[00:11:42.902] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:42.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:13:0) after 1m0s
[00:12:42.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:13:0)
[00:12:42.931] Timer tick, asking Buildbucket for the build status
[00:12:43.002] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:43.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:14:0) after 1m0s
[00:13:43.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:14:0)
[00:13:43.124] Timer tick, asking Buildbucket for the build status
[00:13:43.191] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:43.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:15:0) after 1m0s
[00:14:43.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:15:0)
[00:14:43.338] Timer tick, asking Buildbucket for the build status
[00:14:43.499] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:43.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:16:0) after 1m0s
[00:15:43.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:16:0)
[00:15:43.606] Timer tick, asking Buildbucket for the build status
[00:15:43.721] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:43.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:17:0) after 1m0s
[00:16:43.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:17:0)
[00:16:43.797] Timer tick, asking Buildbucket for the build status
[00:16:44.049] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:44.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:18:0) after 1m0s
[00:17:44.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:18:0)
[00:17:44.066] Timer tick, asking Buildbucket for the build status
[00:17:44.132] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:44.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:19:0) after 1m0s
[00:18:44.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:19:0)
[00:18:44.159] Timer tick, asking Buildbucket for the build status
[00:18:44.264] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:44.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:20:0) after 1m0s
[00:19:44.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:20:0)
[00:19:44.285] Timer tick, asking Buildbucket for the build status
[00:19:44.347] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:44.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:21:0) after 1m0s
[00:20:44.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:21:0)
[00:20:44.530] Timer tick, asking Buildbucket for the build status
[00:20:44.664] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:44.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:22:0) after 1m0s
[00:21:44.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:22:0)
[00:21:44.778] Timer tick, asking Buildbucket for the build status
[00:21:44.851] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:44.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:23:0) after 1m0s
[00:22:44.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:23:0)
[00:22:44.938] Timer tick, asking Buildbucket for the build status
[00:22:45.018] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:45.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:24:0) after 1m0s
[00:23:45.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:24:0)
[00:23:45.035] Timer tick, asking Buildbucket for the build status
[00:23:45.099] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:45.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:25:0) after 1m0s
[00:24:45.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:25:0)
[00:24:45.120] Timer tick, asking Buildbucket for the build status
[00:24:45.260] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:45.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:26:0) after 1m0s
[00:25:45.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:26:0)
[00:25:45.292] Timer tick, asking Buildbucket for the build status
[00:25:45.354] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:45.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:27:0) after 1m0s
[00:26:45.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:27:0)
[00:26:45.382] Timer tick, asking Buildbucket for the build status
[00:26:45.441] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:45.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:28:0) after 1m0s
[00:27:45.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:28:0)
[00:27:45.460] Timer tick, asking Buildbucket for the build status
[00:27:45.589] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:45.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:29:0) after 1m0s
[00:28:45.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:29:0)
[00:28:45.605] Timer tick, asking Buildbucket for the build status
[00:28:45.750] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:45.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:30:0) after 1m0s
[00:29:45.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:30:0)
[00:29:45.786] Timer tick, asking Buildbucket for the build status
[00:29:45.843] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:45.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:31:0) after 1m0s
[00:30:45.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:31:0)
[00:30:45.861] Timer tick, asking Buildbucket for the build status
[00:30:45.941] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:45.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:32:0) after 1m0s
[00:31:46.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:32:0)
[00:31:46.038] Timer tick, asking Buildbucket for the build status
[00:31:46.233] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:46.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:33:0) after 1m0s
[00:32:46.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:33:0)
[00:32:46.254] Timer tick, asking Buildbucket for the build status
[00:32:46.372] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:46.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:34:0) after 1m0s
[00:33:46.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:34:0)
[00:33:46.392] Timer tick, asking Buildbucket for the build status
[00:33:46.638] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:46.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:35:0) after 1m0s
[00:34:46.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:35:0)
[00:34:46.656] Timer tick, asking Buildbucket for the build status
[00:34:46.717] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:46.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:36:0) after 1m0s
[00:35:46.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:36:0)
[00:35:46.741] Timer tick, asking Buildbucket for the build status
[00:35:46.812] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:46.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:37:0) after 1m0s
[00:36:46.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:37:0)
[00:36:46.936] Timer tick, asking Buildbucket for the build status
[00:36:47.138] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:47.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:38:0) after 1m0s
[00:37:47.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:38:0)
[00:37:47.237] Timer tick, asking Buildbucket for the build status
[00:37:47.295] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:47.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:39:0) after 1m0s
[00:38:47.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:39:0)
[00:38:47.315] Timer tick, asking Buildbucket for the build status
[00:38:47.384] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:47.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:40:0) after 1m0s
[00:39:47.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:40:0)
[00:39:47.411] Timer tick, asking Buildbucket for the build status
[00:39:47.485] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:47.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:41:0) after 1m0s
[00:40:47.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:41:0)
[00:40:47.507] Timer tick, asking Buildbucket for the build status
[00:40:47.563] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:47.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:42:0) after 1m0s
[00:41:47.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:42:0)
[00:41:47.598] Timer tick, asking Buildbucket for the build status
[00:41:48.189] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:48.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:43:0) after 1m0s
[00:42:48.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:43:0)
[00:42:48.262] Timer tick, asking Buildbucket for the build status
[00:42:48.453] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:48.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:44:0) after 1m0s
[00:43:48.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:44:0)
[00:43:48.547] Timer tick, asking Buildbucket for the build status
[00:43:48.902] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:45:0) after 1m0s
[00:44:48.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:45:0)
[00:44:48.920] Timer tick, asking Buildbucket for the build status
[00:44:48.981] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:48.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:46:0) after 1m0s
[00:45:49.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:46:0)
[00:45:49.001] Timer tick, asking Buildbucket for the build status
[00:45:49.074] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:49.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:47:0) after 1m0s
[00:46:49.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:47:0)
[00:46:49.096] Timer tick, asking Buildbucket for the build status
[00:46:49.217] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:49.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:48:0) after 1m0s
[00:47:49.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:48:0)
[00:47:49.236] Timer tick, asking Buildbucket for the build status
[00:47:49.361] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:49.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:49:0) after 1m0s
[00:48:49.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:49:0)
[00:48:49.381] Timer tick, asking Buildbucket for the build status
[00:48:49.456] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:49.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:50:0) after 1m0s
[00:49:49.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:50:0)
[00:49:49.475] Timer tick, asking Buildbucket for the build status
[00:49:49.544] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:49.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:51:0) after 1m0s
[00:50:49.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:51:0)
[00:50:49.563] Timer tick, asking Buildbucket for the build status
[00:50:49.809] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:49.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:52:0) after 1m0s
[00:51:49.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:52:0)
[00:51:49.830] Timer tick, asking Buildbucket for the build status
[00:51:49.954] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:49.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:53:0) after 1m0s
[00:52:50.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:53:0)
[00:52:50.007] Timer tick, asking Buildbucket for the build status
[00:52:50.116] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:50.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:54:0) after 1m0s
[00:53:50.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:54:0)
[00:53:50.136] Timer tick, asking Buildbucket for the build status
[00:53:50.168] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:50.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:55:0) after 1m0s
[00:54:50.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:55:0)
[00:54:50.195] Timer tick, asking Buildbucket for the build status
[00:54:50.275] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:50.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:56:0) after 1m0s
[00:55:50.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:56:0)
[00:55:50.304] Timer tick, asking Buildbucket for the build status
[00:55:50.367] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:50.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:57:0) after 1m0s
[00:56:50.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:57:0)
[00:56:50.511] Timer tick, asking Buildbucket for the build status
[00:56:50.710] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:50.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:58:0) after 1m0s
[00:57:50.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:58:0)
[00:57:50.732] Timer tick, asking Buildbucket for the build status
[00:57:50.904] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:50.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:59:0) after 1m0s
[00:58:51.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:59:0)
[00:58:51.343] Timer tick, asking Buildbucket for the build status
[00:58:51.408] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:60:0) after 1m0s
[00:59:51.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:60:0)
[00:59:51.873] Timer tick, asking Buildbucket for the build status
[00:59:52.068] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:52.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:61:0) after 1m0s
[01:00:52.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:61:0)
[01:00:52.312] Timer tick, asking Buildbucket for the build status
[01:00:52.483] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:62:0) after 1m0s
[01:01:53.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:62:0)
[01:01:53.005] Timer tick, asking Buildbucket for the build status
[01:01:53.137] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:53.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:63:0) after 1m0s
[01:02:53.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:63:0)
[01:02:53.677] Timer tick, asking Buildbucket for the build status
[01:02:53.912] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:53.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:64:0) after 1m0s
[01:03:54.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:64:0)
[01:03:54.338] Timer tick, asking Buildbucket for the build status
[01:03:54.535] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:54.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:65:0) after 1m0s
[01:04:55.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:65:0)
[01:04:55.227] Timer tick, asking Buildbucket for the build status
[01:04:55.348] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:55.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:66:0) after 1m0s
[01:05:55.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:66:0)
[01:05:55.992] Timer tick, asking Buildbucket for the build status
[01:05:56.049] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:56.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:67:0) after 1m0s
[01:06:57.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:67:0)
[01:06:57.064] Timer tick, asking Buildbucket for the build status
[01:06:57.134] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:57.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:68:0) after 1m0s
[01:07:57.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:68:0)
[01:07:57.200] Timer tick, asking Buildbucket for the build status
[01:07:57.311] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:69:0) after 1m0s
[01:08:57.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:69:0)
[01:08:57.588] Timer tick, asking Buildbucket for the build status
[01:08:57.912] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:57.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:70:0) after 1m0s
[01:09:58.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:70:0)
[01:09:58.663] Timer tick, asking Buildbucket for the build status
[01:09:58.718] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:58.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:71:0) after 1m0s
[01:10:59.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:71:0)
[01:10:59.605] Timer tick, asking Buildbucket for the build status
[01:11:00.497] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:00.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:72:0) after 1m0s
[01:12:01.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:72:0)
[01:12:01.058] Timer tick, asking Buildbucket for the build status
[01:12:01.454] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:01.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:73:0) after 1m0s
[01:13:02.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:73:0)
[01:13:02.464] Timer tick, asking Buildbucket for the build status
[01:13:02.531] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:02.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:74:0) after 1m0s
[01:14:03.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:74:0)
[01:14:03.212] Timer tick, asking Buildbucket for the build status
[01:14:03.404] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:03.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:75:0) after 1m0s
[01:15:04.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:75:0)
[01:15:04.152] Timer tick, asking Buildbucket for the build status
[01:15:04.315] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:04.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:76:0) after 1m0s
[01:16:04.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:76:0)
[01:16:04.354] Timer tick, asking Buildbucket for the build status
[01:16:04.399] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:04.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:77:0) after 1m0s
[01:17:04.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:77:0)
[01:17:04.522] Timer tick, asking Buildbucket for the build status
[01:17:04.689] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:04.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:78:0) after 1m0s
[01:18:07.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:78:0)
[01:18:07.318] Timer tick, asking Buildbucket for the build status
[01:18:07.417] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:79:0) after 1m0s
[01:19:07.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:79:0)
[01:19:07.536] Timer tick, asking Buildbucket for the build status
[01:19:07.623] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:80:0) after 1m0s
[01:20:08.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:80:0)
[01:20:08.375] Timer tick, asking Buildbucket for the build status
[01:20:08.442] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:08.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:81:0) after 1m0s
[01:21:08.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:81:0)
[01:21:08.473] Timer tick, asking Buildbucket for the build status
[01:21:08.545] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:82:0) after 1m0s
[01:22:08.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:82:0)
[01:22:08.805] Timer tick, asking Buildbucket for the build status
[01:22:08.955] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:83:0) after 1m0s
[01:23:10.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:83:0)
[01:23:10.005] Timer tick, asking Buildbucket for the build status
[01:23:10.070] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:10.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:84:0) after 1m0s
[01:24:10.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:84:0)
[01:24:10.882] Timer tick, asking Buildbucket for the build status
[01:24:10.923] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:85:0) after 1m0s
[01:25:11.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:85:0)
[01:25:11.115] Timer tick, asking Buildbucket for the build status
[01:25:11.177] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:11.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:86:0) after 1m0s
[01:26:11.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:86:0)
[01:26:11.532] Timer tick, asking Buildbucket for the build status
[01:26:11.596] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:11.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:87:0) after 1m0s
[01:27:13.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:87:0)
[01:27:13.128] Timer tick, asking Buildbucket for the build status
[01:27:13.164] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:13.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:88:0) after 1m0s
[01:28:13.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:88:0)
[01:28:13.910] Timer tick, asking Buildbucket for the build status
[01:28:13.975] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:13.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:89:0) after 1m0s
[01:29:14.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:89:0)
[01:29:14.455] Timer tick, asking Buildbucket for the build status
[01:29:14.491] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:14.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:90:0) after 1m0s
[01:30:14.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:90:0)
[01:30:14.513] Timer tick, asking Buildbucket for the build status
[01:30:14.635] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:14.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:91:0) after 1m0s
[01:31:15.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:91:0)
[01:31:15.410] Timer tick, asking Buildbucket for the build status
[01:31:15.608] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:92:0) after 1m0s
[01:32:16.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:92:0)
[01:32:16.452] Timer tick, asking Buildbucket for the build status
[01:32:16.549] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:16.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:93:0) after 1m0s
[01:33:17.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:93:0)
[01:33:17.384] Timer tick, asking Buildbucket for the build status
[01:33:17.612] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:17.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:94:0) after 1m0s
[01:34:18.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:94:0)
[01:34:18.283] Timer tick, asking Buildbucket for the build status
[01:34:18.447] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:18.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:95:0) after 1m0s
[01:35:19.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:95:0)
[01:35:19.312] Timer tick, asking Buildbucket for the build status
[01:35:19.392] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:19.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:96:0) after 1m0s
[01:36:20.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:96:0)
[01:36:20.561] Timer tick, asking Buildbucket for the build status
[01:36:20.634] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:20.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:97:0) after 1m0s
[01:37:21.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:97:0)
[01:37:21.768] Timer tick, asking Buildbucket for the build status
[01:37:21.825] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:21.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:98:0) after 1m0s
[01:38:22.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:98:0)
[01:38:22.668] Timer tick, asking Buildbucket for the build status
[01:38:22.788] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:22.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:99:0) after 1m0s
[01:39:23.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:99:0)
[01:39:23.814] Timer tick, asking Buildbucket for the build status
[01:39:23.926] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:23.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:100:0) after 1m0s
[01:40:25.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:100:0)
[01:40:25.253] Timer tick, asking Buildbucket for the build status
[01:40:25.307] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:101:0) after 1m0s
[01:41:25.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:101:0)
[01:41:25.827] Timer tick, asking Buildbucket for the build status
[01:41:25.909] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:102:0) after 1m0s
[01:42:25.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:102:0)
[01:42:25.971] Timer tick, asking Buildbucket for the build status
[01:42:26.023] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:26.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:103:0) after 1m0s
[01:43:26.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:103:0)
[01:43:26.786] Timer tick, asking Buildbucket for the build status
[01:43:26.851] Build 8935817160978146720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:26.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101247223183770704:104:0) after 1m0s
[01:43:29.960] Received PubSub notification, asking Buildbucket for the build status
[01:43:30.012] Build 8935817160978146720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:43:30.012] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1536543808852710",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536537699680849",
"id": "8935817160978146720",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e173abbe12395f96f27fd79fd476ac6ee0891f92\"}}",
"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/8935817160978146720/+/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\": [\"3769-3c22b45\"], \"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\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"e173abbe12395f96f27fd79fd476ac6ee0891f92\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24631}\", \"$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@{#589811}\", \"branch\": \"refs/heads/master\", \"revision\": \"e173abbe12395f96f27fd79fd476ac6ee0891f92\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d7027dc081cb96791b51524210aa249eb301c056\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"1cee042197da9fdccbf8649e73bf636d93df9c23\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536537699680849, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9101247223183770704\", \"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\": \"8935817160978146720\"}}, \"got_v8_revision\": \"abc91d4174d4019369c60b31b45a440e8ece6682\", \"got_v8_revision_cp\": \"refs/heads/7.1.70@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10033, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"188ad2a7b08a2d3e727a9b663b636d28fb14f05c\", \"notification_helper_unittests\": \"a89039ea80faad7bd215fc4077812f9be4cc036a\", \"gpu_perftests\": \"6e7371ab6909d998a6304cbdd66c51e786cc5ff6\", \"vr_common_unittests\": \"f8e6d6b8de266042045d7722a196b0e2e416520e\", \"telemetry_unittests\": \"84d4512f371ddadd951bc0c2fd8efefdbcefc6a6\", \"load_library_perf_tests\": \"de46ac77f335b4c0b8d75ca66bd2e6cb14f8730a\", \"devtools_closure_compile\": \"7d01ddf637cd20cfde26adfb03767a3010c537fd\", \"chromedriver_py_tests\": \"b2dae823bd7d7ebad229778537f5d15457d11d36\", \"mojo_core_unittests\": \"96bb3564df74911aa49fcd095a19d0bc65d28ac8\", \"install_static_unittests\": \"c06a6ad333e284429661f70c6b61c7161dd3d1b8\", \"leveldb_service_unittests\": \"537164dddc4858e4e3c630b9080a9b3e5e9db368\", \"mini_installer_tests\": \"722755bbf8a04d1265497dfb3bad8b81fa97682c\", \"jingle_unittests\": \"33fbd101a563d1aea72433d52d1e3f3c115607b2\", \"sbox_integration_tests\": \"6a8efcace5926889b88ab179d0ff84f14b1372f3\", \"angle_unittests\": \"c2f1d9d13f7f6bb12446d862b90649e9581cb01d\", \"cast_unittests\": \"6fff9abb484abf2831582819c0a307692f438641\", \"cc_unittests\": \"2be787aef25fe9ff66f95da3f3ea7d7481b4ae62\", \"blink_common_unittests\": \"4ce794f6a6522f65c4fb1226785c6021fb9fe9be\", \"crashpad_tests\": \"4e48867af982b0acdc575716d645f9c286481d54\", \"telemetry_perf_tests_without_chrome\": \"f81d767d5fd94fb352f26f59823a6d18f8248b45\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"8b4051df9c35533dca4c3847f4cf49525cf5f4c5\", \"ppapi_unittests\": \"6cca4f191bd16c3e30900ae177a252cdbf6707b6\", \"extensions_unittests\": \"ea0152d55d108a629778f7780b6f5e4871ed5c09\", \"gl_unittests_ozone\": \"4baf0935f494f05f30ff5feb329d8a13f866d3cd\", \"app_shell_unittests\": \"9a4582ff5fd65832558905f9dd33190abcf7c5de\", \"chrome_app_unittests\": \"d3b681b0cb1abdd171230b76a787f9888c16fd8b\", \"gl_unittests\": \"4baf0935f494f05f30ff5feb329d8a13f866d3cd\", \"gcm_unit_tests\": \"fcdc3b0b9af5fc89a24de00f574212ba6de2e0fc\", \"views_unittests\": \"bfb9bc9a9cef4d2771769ffd4ccd0bc54df794c3\", \"content_shell_crash_test\": \"90aa38c97caff9d0835438f1782cd6233ab2d1dd\", \"ui_base_unittests\": \"a75380aad845d94d90bdda61539d7179c72b60a6\", \"gles2_conform_test\": \"66ca68c3304117eda4e5a2dcc0e47151391c8ee9\", \"cronet_unittests\": \"75ab37d8a3f8c38c62bed72703692174aa07781f\", \"performance_test_suite\": \"eaaa69c0fc96ced2e084ac88f97b72491a78db93\", \"wm_unittests\": \"b8198f802bd025821964c581f301473735ff834a\", \"boringssl_crypto_tests\": \"87b6c3e0c6ea49be86b5b64d51b5807a6bf98bd7\", \"gin_unittests\": \"98e12f354a3aa1ee871d0def05e654837014c10f\", \"performance_browser_tests\": \"465b04fa55054610d383cef775bdfef71e2ff65f\", \"extensions_browsertests\": \"d683b1000ce771dcc77b09633bc1d3cb329ad36a\", \"webkit_python_tests\": \"1587cf1b11ccfc9ac249296bc303fdc301f95ff8\", \"headless_unittests\": \"f9ff0b7b4050156acbb27e451174936ce1d22b0e\", \"webkit_layout_tests\": \"82736adae858ef228a8b45e64a08062880c0a490\", \"vr_pixeltests\": \"1499441d312b6f402ede0c79744f3b7811500640\", \"setup_unittests\": \"dc807ceb7c839ae68eee6c465ea697da29e9a32e\", \"webkit_unit_tests\": \"d07d8f7abfe765c867dd649c0c16ebff4dbb8493\", \"content_unittests\": \"6f439ae9a12381d37cc153a9456ebcc1ba84fb1b\", \"performance_webview_test_suite\": \"89a8ed9c125640302b0dae3da12ff726b6400d43\", \"wtf_unittests\": \"b53996161985bbc0c016533a53e1323c5f1ca2ad\", \"webkit_layout_tests_exparchive\": \"e48a23aa9a064e70d42f83536b96ea8820e1c6c9\", \"chrome_cleaner_unittests\": \"01e4f90c299b3579a9c6fcceda5197513bd3a402\", \"traffic_annotation_auditor_unittests\": \"2708d2567302359a3d82700e3144f50b02f5cb5b\", \"libjingle_xmpp_unittests\": \"b05108b2abcfdc49c2b9f934a08dce5a2b439bbd\", \"remoting_unittests\": \"fe0cef3602ff6a86fcf2681badae2b2ce8e93fdf\", \"vr_common_perftests\": \"cc26720858536071ef7692c7edace67bcfa1c4a0\", \"filesystem_service_unittests\": \"020c9f1aae903ecd4863e1d16deaadd6c31958ce\", \"chrome_elf_import_unittests\": \"25c198efc666de44fb309c090c95ead38e508289\", \"installer_util_unittests\": \"40a18d0bbeefdac65ed925c042095c941e940853\", \"gfx_unittests\": \"c75eb07d302c1f9d61fcb54683707c52594151b8\", \"headless_browsertests\": \"1b665a5fd0cf4e897c4374bfcb1fc2283cc3b233\", \"capture_unittests\": \"f4356c8f32ca7f7c24a34ec6d76e2fb396d9f3f0\", \"chrome_elf_unittests\": \"c460caa36ea8223afc37c290df5e8903b81814c8\", \"telemetry_gpu_unittests\": \"08955bd08769ea24effd8c70e18a22765f836549\", \"command_buffer_perftests\": \"803e7a7692e803646c541c0cf7fcfe694b0ad2f5\", \"media_unittests\": \"5d543783d4b440309828f103dc932ecd8bccb4e8\", \"chromedriver_unittests\": \"867aabbaa52d29856447256d7c8abbba29abc05e\", \"views_mus_interactive_ui_tests\": \"732ad5c5dfe2c599881947697e76015c67e8e92e\", \"storage_unittests\": \"b173a5ffb857e0a4d6cdf5963bfc611f61171cf9\", \"media_service_unittests\": \"f75a1b14367e9efa25e28ea0035a774d71281c2b\", \"compositor_unittests\": \"16ff71136dbcc3da0c8cacf5aac9bd1fc3988337\", \"latency_unittests\": \"43835cb49fb1cc9496e32dff63b7707f259a1d27\", \"video_decode_accelerator_unittest\": \"16356a43a3f4070a2a7e66dfc606f955d6ef5d4d\", \"swiftshader_unittests\": \"80ea8ffe921225aedafa0c4a5c964e89af3e669e\", \"telemetry_perf_unittests\": \"baa94ce7b21ff1f0f443b329e4f1c44a4712bdd6\", \"media_blink_unittests\": \"c04872d652ee8e8edb175958a970ea8ae0cae2cb\", \"views_mus_unittests\": \"39b35cc209a5d1b383f4379fb4b8435ada773a8e\", \"components_unittests\": \"5d6ac43a2d45a964f2309805dbf2f949e09db831\", \"snapshot_unittests\": \"9e1317699f23e618b8bdf96f2547aed3e6d6397a\", \"accessibility_unittests\": \"b26572bc0e3106be660fefc51aa688eb4e1dcc82\", \"net_perftests\": \"fc958f1f83b60e968b86cd6ca7e2e8725d4adddc\", \"aura_unittests\": \"3dc6764cf29bbd7a59149c069c469348eac22e66\", \"services_unittests\": \"50660e797671c4c8d7cac731088f9c3416aa3a0c\", \"components_perftests\": \"fc046dc179f576118be693db0e580364478b818a\", \"events_unittests\": \"00d83c177461ad16205c7e6f1e1c7d7f570a3d99\", \"tracing_perftests\": \"5dca39de8d940c7d6d65c15bb0cfb7e3cbfe3713\", \"chromedriver_replay_unittests\": \"e2ec5b5deadfbf1a0e00246e86e8f3e11e9cace0\", \"ui_touch_selection_unittests\": \"466c4fbb64d0ba6e6c2a30e67201840ceef117df\", \"cacheinvalidation_unittests\": \"35f544cd39355e85d0f656b8111656bf14dbdcff\", \"viz_unittests\": \"d21c1ebe10163c23ce21bf51061d6893497343ea\", \"browser_tests\": \"8c26f2ef306ed85f806fbc47188655ee988ce785\", \"net_unittests\": \"1615fec74ae35da03a2b4c8c32f066bc2b73b5c6\", \"midi_unittests\": \"978b76d0c252acfb2cf35a35c1a39eefd0632bc2\", \"boringssl_ssl_tests\": \"a087de3585d217e18bcc29f88245d6429dfd72d3\", \"sbox_validation_tests\": \"d2d1ce3237739718581478963a0607780f909821\", \"elevation_service_unittests\": \"469594e4afa2d04a766c5cf4347a13026d6c454f\", \"gpu_unittests\": \"89758eeadc4e538449f1d75e26ae3e0bdc635096\", \"native_theme_unittests\": \"7946f03b24a7a26ec9f35d30837bdfb6184674a5\", \"interactive_ui_tests\": \"dfb9145e6854919ea36819832d369168ee9228df\", \"mojo_unittests\": \"cea1552e144c09b6715c9f35232692cba463aec8\", \"url_unittests\": \"af48ac68f641537eeb8b8a9657d9830a6b1f0ac0\", \"media_perftests\": \"9b4b72b575694c36865b97c95802ed2b56c633ab\", \"cronet_tests\": \"9827d6a458b60e39f64ec3bc5058fa1a37f11b1a\", \"google_apis_unittests\": \"71f63570b6cc01073496cd210da6060656694d80\", \"telemetry_gpu_integration_test\": \"2924910e41e2f07b2f6dbb17f03cbcc62e7f8ace\", \"blink_heap_unittests\": \"63a95e581fdcf5b56e21986d0323878aca8f2bfa\", \"base_unittests\": \"2c29a0cadbf1d1f8d0f92af0e0a5668ce74687b5\", \"sync_integration_tests\": \"eb2b822870699e68cf453477c99019c2ee92c8ea\", \"sql_unittests\": \"d8f89f698e23195e74d0985aec34edc2397642cf\", \"courgette_unittests\": \"efba834b138eace53c2d53350843301a3f506f0e\", \"blink_fuzzer_unittests\": \"907be5d38c7e213ab0031e3a0b9029397d15992a\", \"gl_tests\": \"6158295156d8124a22c6560ea7710e7d83eb4783\", \"zucchini_unittests\": \"323f07c22a18797ec734e01390dfcff41239a12d\", \"ipc_tests\": \"3da51a680a0487a9103a0a8c5130de3f2ebc005e\", \"angle_end2end_tests\": \"50ab215464f973926e5b6be57a1dacc361986267\", \"blink_platform_unittests\": \"ed4e9d3d11fd205a801ca005f821d1041695dced\", \"components_browsertests\": \"449647180662e9f44663f581be89ae05040179ba\", \"views_perftests\": \"a741d3f01ac9de34b49d1073c4a098be45e31bf2\", \"angle_perftests\": \"4d4d42a710ab4dceb1a231431952c1a906177fd3\", \"display_unittests\": \"532029b3d6816c5410edbcd5adc17dcf79e2a632\", \"sbox_unittests\": \"b245459ad2dbd8810573c529993824ad7a2a3418\", \"service_manager_unittests\": \"6edbfa74146212d0e9bf5240e6f1fb1f61410adc\", \"pdf_unittests\": \"9d4fa96a71b25a927fcc8d0ef7ab2ddcbae40459\", \"skia_unittests\": \"25da2fbc3928111d00dfb93c8c280b5bac34f5fe\", \"angle_white_box_tests\": \"2ba05664c7936a928736116b5403860e2ceeff0d\", \"crypto_unittests\": \"14f3652905d9a2f56d6d02d2e0cd78dbdc9718ca\", \"nacl_loader_unittests\": \"04152b1e8570a6cfab0d1e75a338d02a722f971d\", \"unit_tests\": \"92097c47f2664b6bb7d5b53734d7ee947fe9a24f\", \"content_browsertests\": \"2179412324e666a7b4eafadf8dc41f043c260363\", \"printing_unittests\": \"868caa5cdc9249029a63a19aa42081c4329b9a67\", \"device_unittests\": \"70692ae3a3350307affc0903193fa205cb098187\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536537700785518",
"status": "COMPLETED",
"status_changed_ts": "1536543809306244",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10033",
"builder:Windows deterministic",
"buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101247223183770704",
"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/10033",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935817160978146720",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e173abbe12395f96f27fd79fd476ac6ee0891f92",
"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/8935817160978146720/+/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:9101247223183770704",
"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:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fd99a3057e5d810",
"user_agent:luci-scheduler"
],
"updated_ts": "1536543809307655",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10033",
"utcnow_ts": "1536543809993996"
}
}
[01:43:30.012] Invocation finished in 1h41m51.81944333s with status SUCCEEDED