[12:48:18.313] New invocation is queued and will start shortly
[12:48:19.599] Starting the invocation (attempt 1)
[12:48:19.630] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:48:19.630] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:48:19.630] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9093226455536106544",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"49f80a482f5f426a03c09bc262dd9d645a008223\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9093226455536106544",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223",
"gitiles_ref:refs/heads/master"
]
}
[12:48:21.212] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1544186899750266",
"id": "8927796393366272016",
"lease_expiration_ts": "1544305700948745",
"lease_key": "59261700",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"49f80a482f5f426a03c09bc262dd9d645a008223\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1544186901034588",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10996",
"builder:Windows deterministic",
"buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9093226455536106544",
"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/10996",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8927796393366272016",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223",
"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/8927796393366272016/+/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:9093226455536106544",
"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:4c7e82833f2401af609d022aef129959feb178af",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41a187b8e5868d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1544186901034660",
"url": "https://ci.chromium.org/b/8927796393366272016",
"utcnow_ts": "1544186901176392"
}
}
[12:48:21.212] Task URL: https://ci.chromium.org/b/8927796393366272016
[12:48:21.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:2:0) after 1m0s
[12:48:24.273] Received PubSub notification, asking Buildbucket for the build status
[12:48:24.304] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:21.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:2:0)
[12:49:21.229] Timer tick, asking Buildbucket for the build status
[12:49:21.280] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:21.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:4:0) after 1m0s
[12:50:21.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:4:0)
[12:50:21.303] Timer tick, asking Buildbucket for the build status
[12:50:21.447] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:21.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:5:0) after 1m0s
[12:51:21.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:5:0)
[12:51:21.463] Timer tick, asking Buildbucket for the build status
[12:51:21.680] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:21.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:6:0) after 1m0s
[12:52:21.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:6:0)
[12:52:21.708] Timer tick, asking Buildbucket for the build status
[12:52:21.864] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:7:0) after 1m0s
[12:53:21.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:7:0)
[12:53:21.903] Timer tick, asking Buildbucket for the build status
[12:53:22.069] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:22.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:8:0) after 1m0s
[12:54:22.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:8:0)
[12:54:22.109] Timer tick, asking Buildbucket for the build status
[12:54:22.163] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:22.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:9:0) after 1m0s
[12:55:22.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:9:0)
[12:55:22.181] Timer tick, asking Buildbucket for the build status
[12:55:22.243] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:22.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:10:0) after 1m0s
[12:56:22.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:10:0)
[12:56:22.259] Timer tick, asking Buildbucket for the build status
[12:56:22.591] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:22.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:11:0) after 1m0s
[12:57:22.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:11:0)
[12:57:22.630] Timer tick, asking Buildbucket for the build status
[12:57:22.709] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:22.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:12:0) after 1m0s
[12:58:22.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:12:0)
[12:58:22.736] Timer tick, asking Buildbucket for the build status
[12:58:22.845] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:13:0) after 1m0s
[12:59:22.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:13:0)
[12:59:22.861] Timer tick, asking Buildbucket for the build status
[12:59:22.966] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:22.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:14:0) after 1m0s
[13:00:22.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:14:0)
[13:00:22.983] Timer tick, asking Buildbucket for the build status
[13:00:23.194] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:23.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:15:0) after 1m0s
[13:01:23.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:15:0)
[13:01:23.211] Timer tick, asking Buildbucket for the build status
[13:01:23.256] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:23.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:16:0) after 1m0s
[13:02:23.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:16:0)
[13:02:23.289] Timer tick, asking Buildbucket for the build status
[13:02:23.346] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:23.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:17:0) after 1m0s
[13:03:23.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:17:0)
[13:03:23.364] Timer tick, asking Buildbucket for the build status
[13:03:23.422] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:23.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:18:0) after 1m0s
[13:04:23.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:18:0)
[13:04:23.440] Timer tick, asking Buildbucket for the build status
[13:04:23.496] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:23.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:19:0) after 1m0s
[13:05:23.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:19:0)
[13:05:23.515] Timer tick, asking Buildbucket for the build status
[13:05:23.642] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:23.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:20:0) after 1m0s
[13:06:23.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:20:0)
[13:06:23.659] Timer tick, asking Buildbucket for the build status
[13:06:23.692] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:23.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:21:0) after 1m0s
[13:07:23.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:21:0)
[13:07:23.717] Timer tick, asking Buildbucket for the build status
[13:07:23.820] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:23.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:22:0) after 1m0s
[13:08:23.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:22:0)
[13:08:23.845] Timer tick, asking Buildbucket for the build status
[13:08:23.950] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:23.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:23:0) after 1m0s
[13:09:23.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:23:0)
[13:09:23.970] Timer tick, asking Buildbucket for the build status
[13:09:24.108] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:24:0) after 1m0s
[13:10:24.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:24:0)
[13:10:24.141] Timer tick, asking Buildbucket for the build status
[13:10:24.175] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:24.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:25:0) after 1m0s
[13:11:24.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:25:0)
[13:11:24.192] Timer tick, asking Buildbucket for the build status
[13:11:24.244] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:26:0) after 1m0s
[13:12:24.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:26:0)
[13:12:24.260] Timer tick, asking Buildbucket for the build status
[13:12:24.317] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:24.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:27:0) after 1m0s
[13:13:24.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:27:0)
[13:13:24.335] Timer tick, asking Buildbucket for the build status
[13:13:24.490] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:24.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:28:0) after 1m0s
[13:14:24.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:28:0)
[13:14:24.507] Timer tick, asking Buildbucket for the build status
[13:14:24.619] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:24.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:29:0) after 1m0s
[13:15:24.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:29:0)
[13:15:24.645] Timer tick, asking Buildbucket for the build status
[13:15:24.710] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:24.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:30:0) after 1m0s
[13:16:24.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:30:0)
[13:16:24.737] Timer tick, asking Buildbucket for the build status
[13:16:24.798] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:24.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:31:0) after 1m0s
[13:17:24.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:31:0)
[13:17:24.816] Timer tick, asking Buildbucket for the build status
[13:17:24.949] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:24.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:32:0) after 1m0s
[13:18:24.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:32:0)
[13:18:24.967] Timer tick, asking Buildbucket for the build status
[13:18:25.108] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:25.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:33:0) after 1m0s
[13:19:25.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:33:0)
[13:19:25.126] Timer tick, asking Buildbucket for the build status
[13:19:25.203] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:25.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:34:0) after 1m0s
[13:20:25.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:34:0)
[13:20:25.225] Timer tick, asking Buildbucket for the build status
[13:20:25.272] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:25.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:35:0) after 1m0s
[13:21:25.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:35:0)
[13:21:25.290] Timer tick, asking Buildbucket for the build status
[13:21:25.359] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:25.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:36:0) after 1m0s
[13:22:25.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:36:0)
[13:22:25.377] Timer tick, asking Buildbucket for the build status
[13:22:25.473] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:25.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:37:0) after 1m0s
[13:23:25.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:37:0)
[13:23:25.493] Timer tick, asking Buildbucket for the build status
[13:23:25.539] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:25.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:38:0) after 1m0s
[13:24:25.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:38:0)
[13:24:25.562] Timer tick, asking Buildbucket for the build status
[13:24:25.598] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:25.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:39:0) after 1m0s
[13:25:25.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:39:0)
[13:25:25.660] Timer tick, asking Buildbucket for the build status
[13:25:25.813] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:40:0) after 1m0s
[13:26:25.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:40:0)
[13:26:25.838] Timer tick, asking Buildbucket for the build status
[13:26:25.872] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:25.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:41:0) after 1m0s
[13:27:25.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:41:0)
[13:27:25.890] Timer tick, asking Buildbucket for the build status
[13:27:26.102] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:26.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:42:0) after 1m0s
[13:28:26.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:42:0)
[13:28:26.155] Timer tick, asking Buildbucket for the build status
[13:28:26.281] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:26.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:43:0) after 1m0s
[13:29:26.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:43:0)
[13:29:26.340] Timer tick, asking Buildbucket for the build status
[13:29:26.457] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:26.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:44:0) after 1m0s
[13:30:26.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:44:0)
[13:30:26.477] Timer tick, asking Buildbucket for the build status
[13:30:26.511] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:26.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:45:0) after 1m0s
[13:31:26.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:45:0)
[13:31:26.583] Timer tick, asking Buildbucket for the build status
[13:31:26.653] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:26.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:46:0) after 1m0s
[13:32:26.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:46:0)
[13:32:26.674] Timer tick, asking Buildbucket for the build status
[13:32:26.724] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:26.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:47:0) after 1m0s
[13:33:26.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:47:0)
[13:33:26.782] Timer tick, asking Buildbucket for the build status
[13:33:26.927] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:26.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:48:0) after 1m0s
[13:34:26.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:48:0)
[13:34:26.966] Timer tick, asking Buildbucket for the build status
[13:34:29.065] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:29.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:49:0) after 1m0s
[13:35:29.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:49:0)
[13:35:29.086] Timer tick, asking Buildbucket for the build status
[13:35:29.125] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:29.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:50:0) after 1m0s
[13:36:29.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:50:0)
[13:36:29.149] Timer tick, asking Buildbucket for the build status
[13:36:29.234] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:29.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:51:0) after 1m0s
[13:37:29.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:51:0)
[13:37:29.251] Timer tick, asking Buildbucket for the build status
[13:37:29.289] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:29.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:52:0) after 1m0s
[13:38:29.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:52:0)
[13:38:29.309] Timer tick, asking Buildbucket for the build status
[13:38:29.358] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:29.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:53:0) after 1m0s
[13:39:29.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:53:0)
[13:39:29.380] Timer tick, asking Buildbucket for the build status
[13:39:29.487] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:29.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:54:0) after 1m0s
[13:40:29.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:54:0)
[13:40:29.508] Timer tick, asking Buildbucket for the build status
[13:40:29.645] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:29.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:55:0) after 1m0s
[13:41:29.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:55:0)
[13:41:29.662] Timer tick, asking Buildbucket for the build status
[13:41:29.800] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:29.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:56:0) after 1m0s
[13:42:29.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:56:0)
[13:42:29.816] Timer tick, asking Buildbucket for the build status
[13:42:29.871] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:57:0) after 1m0s
[13:43:29.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:57:0)
[13:43:29.896] Timer tick, asking Buildbucket for the build status
[13:43:30.198] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:30.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:58:0) after 1m0s
[13:44:30.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:58:0)
[13:44:30.216] Timer tick, asking Buildbucket for the build status
[13:44:30.286] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:30.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:59:0) after 1m0s
[13:45:30.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:59:0)
[13:45:30.317] Timer tick, asking Buildbucket for the build status
[13:45:30.376] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:30.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:60:0) after 1m0s
[13:46:30.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:60:0)
[13:46:30.397] Timer tick, asking Buildbucket for the build status
[13:46:30.447] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:30.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:61:0) after 1m0s
[13:47:30.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:61:0)
[13:47:30.484] Timer tick, asking Buildbucket for the build status
[13:47:30.541] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:30.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:62:0) after 1m0s
[13:48:30.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:62:0)
[13:48:30.557] Timer tick, asking Buildbucket for the build status
[13:48:30.612] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:30.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:63:0) after 1m0s
[13:49:30.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:63:0)
[13:49:30.631] Timer tick, asking Buildbucket for the build status
[13:49:30.719] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:30.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:64:0) after 1m0s
[13:50:30.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:64:0)
[13:50:30.820] Timer tick, asking Buildbucket for the build status
[13:50:30.852] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:30.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:65:0) after 1m0s
[13:51:30.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:65:0)
[13:51:30.904] Timer tick, asking Buildbucket for the build status
[13:51:30.983] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:30.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:66:0) after 1m0s
[13:52:31.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:66:0)
[13:52:31.024] Timer tick, asking Buildbucket for the build status
[13:52:31.067] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:31.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:67:0) after 1m0s
[13:53:31.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:67:0)
[13:53:31.117] Timer tick, asking Buildbucket for the build status
[13:53:31.258] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:31.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:68:0) after 1m0s
[13:54:31.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:68:0)
[13:54:31.283] Timer tick, asking Buildbucket for the build status
[13:54:31.335] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:69:0) after 1m0s
[13:55:31.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:69:0)
[13:55:31.358] Timer tick, asking Buildbucket for the build status
[13:55:31.391] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:31.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:70:0) after 1m0s
[13:56:31.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:70:0)
[13:56:31.409] Timer tick, asking Buildbucket for the build status
[13:56:31.471] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:31.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:71:0) after 1m0s
[13:57:31.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:71:0)
[13:57:31.489] Timer tick, asking Buildbucket for the build status
[13:57:31.526] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:31.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:72:0) after 1m0s
[13:58:31.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:72:0)
[13:58:31.545] Timer tick, asking Buildbucket for the build status
[13:58:31.579] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:31.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:73:0) after 1m0s
[13:59:31.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:73:0)
[13:59:31.631] Timer tick, asking Buildbucket for the build status
[13:59:31.688] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:31.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:74:0) after 1m0s
[14:00:31.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:74:0)
[14:00:31.718] Timer tick, asking Buildbucket for the build status
[14:00:31.758] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:31.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:75:0) after 1m0s
[14:01:31.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:75:0)
[14:01:31.777] Timer tick, asking Buildbucket for the build status
[14:01:31.890] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:31.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:76:0) after 1m0s
[14:02:31.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:76:0)
[14:02:31.911] Timer tick, asking Buildbucket for the build status
[14:02:32.045] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:77:0) after 1m0s
[14:03:32.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:77:0)
[14:03:32.073] Timer tick, asking Buildbucket for the build status
[14:03:32.171] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:32.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:78:0) after 1m0s
[14:04:32.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:78:0)
[14:04:32.194] Timer tick, asking Buildbucket for the build status
[14:04:32.257] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:32.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:79:0) after 1m0s
[14:05:32.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:79:0)
[14:05:32.275] Timer tick, asking Buildbucket for the build status
[14:05:32.357] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:32.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:80:0) after 1m0s
[14:06:32.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:80:0)
[14:06:32.431] Timer tick, asking Buildbucket for the build status
[14:06:32.497] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:32.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:81:0) after 1m0s
[14:07:32.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:81:0)
[14:07:32.536] Timer tick, asking Buildbucket for the build status
[14:07:32.629] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:32.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:82:0) after 1m0s
[14:08:32.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:82:0)
[14:08:32.731] Timer tick, asking Buildbucket for the build status
[14:08:32.775] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:32.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:83:0) after 1m0s
[14:09:32.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:83:0)
[14:09:32.796] Timer tick, asking Buildbucket for the build status
[14:09:32.967] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:32.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:84:0) after 1m0s
[14:10:32.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:84:0)
[14:10:32.992] Timer tick, asking Buildbucket for the build status
[14:10:33.045] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:33.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:85:0) after 1m0s
[14:11:33.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:85:0)
[14:11:33.088] Timer tick, asking Buildbucket for the build status
[14:11:33.132] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:33.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:86:0) after 1m0s
[14:12:33.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:86:0)
[14:12:33.154] Timer tick, asking Buildbucket for the build status
[14:12:33.187] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:87:0) after 1m0s
[14:13:33.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:87:0)
[14:13:33.221] Timer tick, asking Buildbucket for the build status
[14:13:33.325] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:88:0) after 1m0s
[14:14:33.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:88:0)
[14:14:33.346] Timer tick, asking Buildbucket for the build status
[14:14:33.438] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:33.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:89:0) after 1m0s
[14:15:33.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:89:0)
[14:15:33.461] Timer tick, asking Buildbucket for the build status
[14:15:33.516] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:33.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:90:0) after 1m0s
[14:16:33.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:90:0)
[14:16:33.552] Timer tick, asking Buildbucket for the build status
[14:16:33.590] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:33.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:91:0) after 1m0s
[14:17:33.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:91:0)
[14:17:33.611] Timer tick, asking Buildbucket for the build status
[14:17:33.739] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:33.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:92:0) after 1m0s
[14:18:33.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:92:0)
[14:18:33.759] Timer tick, asking Buildbucket for the build status
[14:18:33.946] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:33.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:93:0) after 1m0s
[14:19:33.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:93:0)
[14:19:33.965] Timer tick, asking Buildbucket for the build status
[14:19:34.038] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:94:0) after 1m0s
[14:20:34.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:94:0)
[14:20:34.067] Timer tick, asking Buildbucket for the build status
[14:20:34.129] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:34.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:95:0) after 1m0s
[14:21:34.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:95:0)
[14:21:34.151] Timer tick, asking Buildbucket for the build status
[14:21:34.359] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:34.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:96:0) after 1m0s
[14:22:34.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:96:0)
[14:22:34.379] Timer tick, asking Buildbucket for the build status
[14:22:34.418] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:34.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:97:0) after 1m0s
[14:23:34.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:97:0)
[14:23:34.443] Timer tick, asking Buildbucket for the build status
[14:23:34.523] Build 8927796393366272016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:34.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093226455536106544:98:0) after 1m0s
[14:23:48.104] Received PubSub notification, asking Buildbucket for the build status
[14:23:48.160] Build 8927796393366272016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:23:48.160] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1544192627383403",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1544186899750266",
"id": "8927796393366272016",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"49f80a482f5f426a03c09bc262dd9d645a008223\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"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\"], \"id\": [\"swarm2173-c4\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3921-6311e5b\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"8e13fe5e85640b063aefcb88a3ccb52abf6e28e8\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"49f80a482f5f426a03c09bc262dd9d645a008223\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"0f50114b3c6849238eedf95236137d614fed4be2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25919}\", \"$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@{#614676}\", \"branch\": \"refs/heads/master\", \"revision\": \"49f80a482f5f426a03c09bc262dd9d645a008223\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"18f0c3c038fc45be6951301a3c2726e6810565d3\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"e14feaf5b9aaa5bbe880ab9f67e0cf3fd5201ab8\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1544186899750266, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9093226455536106544\", \"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\": \"8927796393366272016\"}}, \"got_v8_revision\": \"845f9d53df1192a0d87d67472c6737d09ed929e5\", \"got_v8_revision_cp\": \"refs/heads/7.3.59@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10996, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"7d88270de197ebe8b439ab5eb57a4a2a0bb810e0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1544186903034522",
"status": "COMPLETED",
"status_changed_ts": "1544192627825217",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10996",
"builder:Windows deterministic",
"buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9093226455536106544",
"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/10996",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8927796393366272016",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/49f80a482f5f426a03c09bc262dd9d645a008223",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49f80a482f5f426a03c09bc262dd9d645a008223",
"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/8927796393366272016/+/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:9093226455536106544",
"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:4c7e82833f2401af609d022aef129959feb178af",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41a187b8e5868d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1544192627826317",
"url": "https://ci.chromium.org/b/8927796393366272016",
"utcnow_ts": "1544192628140618"
}
}
[14:23:48.160] Invocation finished in 1h35m29.86272141s with status SUCCEEDED