[13:01:58.260] New invocation is queued and will start shortly
[13:01:59.623] Starting the invocation (attempt 1)
[13:01:59.659] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:01:59.659] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:01:59.659] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9099386189474654080",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"39046b91a7f47735a6180e056c7ce6bf3cf8ce06\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9099386189474654080",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"gitiles_ref:refs/heads/master"
]
}
[13:02:04.293] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538312519738057",
"id": "8933956127261519328",
"lease_expiration_ts": "1538456524076931",
"lease_key": "1637128266",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"39046b91a7f47735a6180e056c7ce6bf3cf8ce06\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538312524203686",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10249",
"builder:Windows deterministic",
"buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099386189474654080",
"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/10249",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933956127261519328",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"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/8933956127261519328/+/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:9099386189474654080",
"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:216ff455080a4f94ea455f4ef2ee62b8417f1092",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:404363d5e9690d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1538312524203778",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10249",
"utcnow_ts": "1538312524281280"
}
}
[13:02:04.293] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10249
[13:02:04.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:2:0) after 1m0s
[13:02:06.253] Received PubSub notification, asking Buildbucket for the build status
[13:02:06.356] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:04.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:2:0)
[13:03:04.308] Timer tick, asking Buildbucket for the build status
[13:03:04.340] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:04.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:4:0) after 1m0s
[13:04:04.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:4:0)
[13:04:04.358] Timer tick, asking Buildbucket for the build status
[13:04:04.594] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:04.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:5:0) after 1m0s
[13:05:04.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:5:0)
[13:05:04.611] Timer tick, asking Buildbucket for the build status
[13:05:04.820] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:04.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:6:0) after 1m0s
[13:06:05.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:6:0)
[13:06:05.020] Timer tick, asking Buildbucket for the build status
[13:06:05.079] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:05.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:7:0) after 1m0s
[13:07:05.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:7:0)
[13:07:05.094] Timer tick, asking Buildbucket for the build status
[13:07:05.188] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:05.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:8:0) after 1m0s
[13:08:05.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:8:0)
[13:08:05.209] Timer tick, asking Buildbucket for the build status
[13:08:05.575] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:05.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:9:0) after 1m0s
[13:09:05.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:9:0)
[13:09:05.593] Timer tick, asking Buildbucket for the build status
[13:09:05.624] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:05.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:10:0) after 1m0s
[13:10:05.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:10:0)
[13:10:05.641] Timer tick, asking Buildbucket for the build status
[13:10:05.699] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:05.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:11:0) after 1m0s
[13:11:05.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:11:0)
[13:11:05.725] Timer tick, asking Buildbucket for the build status
[13:11:05.835] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:12:0) after 1m0s
[13:12:05.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:12:0)
[13:12:05.853] Timer tick, asking Buildbucket for the build status
[13:12:05.935] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:05.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:13:0) after 1m0s
[13:13:05.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:13:0)
[13:13:05.951] Timer tick, asking Buildbucket for the build status
[13:13:06.131] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:06.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:14:0) after 1m0s
[13:14:06.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:14:0)
[13:14:06.147] Timer tick, asking Buildbucket for the build status
[13:14:06.208] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:06.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:15:0) after 1m0s
[13:15:06.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:15:0)
[13:15:06.225] Timer tick, asking Buildbucket for the build status
[13:15:06.379] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:06.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:16:0) after 1m0s
[13:16:06.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:16:0)
[13:16:06.395] Timer tick, asking Buildbucket for the build status
[13:16:06.521] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:06.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:17:0) after 1m0s
[13:17:06.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:17:0)
[13:17:06.559] Timer tick, asking Buildbucket for the build status
[13:17:06.876] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:06.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:18:0) after 1m0s
[13:18:06.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:18:0)
[13:18:06.893] Timer tick, asking Buildbucket for the build status
[13:18:06.971] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:06.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:19:0) after 1m0s
[13:19:06.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:19:0)
[13:19:06.992] Timer tick, asking Buildbucket for the build status
[13:19:07.034] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:20:0) after 1m0s
[13:20:07.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:20:0)
[13:20:07.052] Timer tick, asking Buildbucket for the build status
[13:20:07.179] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:07.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:21:0) after 1m0s
[13:21:07.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:21:0)
[13:21:07.197] Timer tick, asking Buildbucket for the build status
[13:21:07.255] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:07.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:22:0) after 1m0s
[13:22:07.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:22:0)
[13:22:07.282] Timer tick, asking Buildbucket for the build status
[13:22:07.426] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:07.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:23:0) after 1m0s
[13:23:07.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:23:0)
[13:23:07.453] Timer tick, asking Buildbucket for the build status
[13:23:07.582] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:07.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:24:0) after 1m0s
[13:24:07.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:24:0)
[13:24:07.610] Timer tick, asking Buildbucket for the build status
[13:24:07.649] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:07.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:25:0) after 1m0s
[13:25:07.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:25:0)
[13:25:07.673] Timer tick, asking Buildbucket for the build status
[13:25:07.725] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:07.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:26:0) after 1m0s
[13:26:07.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:26:0)
[13:26:07.743] Timer tick, asking Buildbucket for the build status
[13:26:07.822] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:07.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:27:0) after 1m0s
[13:27:07.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:27:0)
[13:27:07.917] Timer tick, asking Buildbucket for the build status
[13:27:07.992] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:07.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:28:0) after 1m0s
[13:28:08.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:28:0)
[13:28:08.049] Timer tick, asking Buildbucket for the build status
[13:28:08.116] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:08.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:29:0) after 1m0s
[13:29:08.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:29:0)
[13:29:08.151] Timer tick, asking Buildbucket for the build status
[13:29:08.431] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:30:0) after 1m0s
[13:30:08.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:30:0)
[13:30:08.449] Timer tick, asking Buildbucket for the build status
[13:30:08.507] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:08.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:31:0) after 1m0s
[13:31:08.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:31:0)
[13:31:08.536] Timer tick, asking Buildbucket for the build status
[13:31:08.620] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:08.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:32:0) after 1m0s
[13:32:08.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:32:0)
[13:32:08.638] Timer tick, asking Buildbucket for the build status
[13:32:08.712] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:08.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:33:0) after 1m0s
[13:33:08.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:33:0)
[13:33:08.732] Timer tick, asking Buildbucket for the build status
[13:33:08.810] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:08.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:34:0) after 1m0s
[13:34:08.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:34:0)
[13:34:08.830] Timer tick, asking Buildbucket for the build status
[13:34:08.891] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:08.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:35:0) after 1m0s
[13:35:08.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:35:0)
[13:35:08.939] Timer tick, asking Buildbucket for the build status
[13:35:09.028] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:09.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:36:0) after 1m0s
[13:36:09.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:36:0)
[13:36:09.055] Timer tick, asking Buildbucket for the build status
[13:36:09.111] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:09.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:37:0) after 1m0s
[13:37:09.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:37:0)
[13:37:09.191] Timer tick, asking Buildbucket for the build status
[13:37:09.252] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:09.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:38:0) after 1m0s
[13:38:09.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:38:0)
[13:38:09.269] Timer tick, asking Buildbucket for the build status
[13:38:09.401] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:09.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:39:0) after 1m0s
[13:39:09.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:39:0)
[13:39:09.419] Timer tick, asking Buildbucket for the build status
[13:39:09.487] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:09.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:40:0) after 1m0s
[13:40:09.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:40:0)
[13:40:09.559] Timer tick, asking Buildbucket for the build status
[13:40:09.607] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:09.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:41:0) after 1m0s
[13:41:09.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:41:0)
[13:41:09.639] Timer tick, asking Buildbucket for the build status
[13:41:09.687] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:09.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:42:0) after 1m0s
[13:42:09.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:42:0)
[13:42:09.709] Timer tick, asking Buildbucket for the build status
[13:42:10.815] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:10.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:43:0) after 1m0s
[13:43:10.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:43:0)
[13:43:10.834] Timer tick, asking Buildbucket for the build status
[13:43:10.901] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:44:0) after 1m0s
[13:44:10.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:44:0)
[13:44:10.920] Timer tick, asking Buildbucket for the build status
[13:44:10.972] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:10.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:45:0) after 1m0s
[13:45:11.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:45:0)
[13:45:11.018] Timer tick, asking Buildbucket for the build status
[13:45:11.056] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:11.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:46:0) after 1m0s
[13:46:11.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:46:0)
[13:46:11.077] Timer tick, asking Buildbucket for the build status
[13:46:11.139] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:11.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:47:0) after 1m0s
[13:47:11.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:47:0)
[13:47:11.158] Timer tick, asking Buildbucket for the build status
[13:47:11.221] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:48:0) after 1m0s
[13:48:11.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:48:0)
[13:48:11.242] Timer tick, asking Buildbucket for the build status
[13:48:11.298] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:11.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:49:0) after 1m0s
[13:49:11.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:49:0)
[13:49:11.319] Timer tick, asking Buildbucket for the build status
[13:49:11.376] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:11.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:50:0) after 1m0s
[13:50:11.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:50:0)
[13:50:11.396] Timer tick, asking Buildbucket for the build status
[13:50:11.514] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:11.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:51:0) after 1m0s
[13:51:11.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:51:0)
[13:51:11.532] Timer tick, asking Buildbucket for the build status
[13:51:11.668] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:11.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:52:0) after 1m0s
[13:52:11.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:52:0)
[13:52:11.720] Timer tick, asking Buildbucket for the build status
[13:52:11.778] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:11.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:53:0) after 1m0s
[13:53:11.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:53:0)
[13:53:11.906] Timer tick, asking Buildbucket for the build status
[13:53:11.985] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:11.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:54:0) after 1m0s
[13:54:12.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:54:0)
[13:54:12.006] Timer tick, asking Buildbucket for the build status
[13:54:12.110] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:55:0) after 1m0s
[13:55:12.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:55:0)
[13:55:12.134] Timer tick, asking Buildbucket for the build status
[13:55:12.224] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:12.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:56:0) after 1m0s
[13:56:12.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:56:0)
[13:56:12.245] Timer tick, asking Buildbucket for the build status
[13:56:12.325] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:12.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:57:0) after 1m0s
[13:57:12.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:57:0)
[13:57:12.345] Timer tick, asking Buildbucket for the build status
[13:57:12.387] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:12.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:58:0) after 1m0s
[13:58:12.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:58:0)
[13:58:12.406] Timer tick, asking Buildbucket for the build status
[13:58:12.451] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:12.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:59:0) after 1m0s
[13:59:12.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:59:0)
[13:59:12.472] Timer tick, asking Buildbucket for the build status
[13:59:12.536] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:12.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:60:0) after 1m0s
[14:00:12.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:60:0)
[14:00:12.553] Timer tick, asking Buildbucket for the build status
[14:00:12.618] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:12.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:61:0) after 1m0s
[14:01:12.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:61:0)
[14:01:12.638] Timer tick, asking Buildbucket for the build status
[14:01:12.695] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:12.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:62:0) after 1m0s
[14:02:12.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:62:0)
[14:02:12.716] Timer tick, asking Buildbucket for the build status
[14:02:12.759] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:12.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:63:0) after 1m0s
[14:03:12.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:63:0)
[14:03:12.781] Timer tick, asking Buildbucket for the build status
[14:03:12.842] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:12.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:64:0) after 1m0s
[14:04:12.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:64:0)
[14:04:12.867] Timer tick, asking Buildbucket for the build status
[14:04:12.937] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:12.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:65:0) after 1m0s
[14:05:12.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:65:0)
[14:05:12.957] Timer tick, asking Buildbucket for the build status
[14:05:13.361] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:13.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:66:0) after 1m0s
[14:06:13.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:66:0)
[14:06:13.419] Timer tick, asking Buildbucket for the build status
[14:06:13.660] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:13.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:67:0) after 1m0s
[14:07:13.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:67:0)
[14:07:13.681] Timer tick, asking Buildbucket for the build status
[14:07:13.719] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:13.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:68:0) after 1m0s
[14:08:13.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:68:0)
[14:08:13.741] Timer tick, asking Buildbucket for the build status
[14:08:13.930] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:13.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:69:0) after 1m0s
[14:09:13.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:69:0)
[14:09:13.952] Timer tick, asking Buildbucket for the build status
[14:09:14.232] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:14.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:70:0) after 1m0s
[14:10:14.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:70:0)
[14:10:14.288] Timer tick, asking Buildbucket for the build status
[14:10:14.391] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:14.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:71:0) after 1m0s
[14:11:14.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:71:0)
[14:11:14.411] Timer tick, asking Buildbucket for the build status
[14:11:14.669] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:72:0) after 1m0s
[14:12:14.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:72:0)
[14:12:14.688] Timer tick, asking Buildbucket for the build status
[14:12:14.737] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:14.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:73:0) after 1m0s
[14:13:14.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:73:0)
[14:13:14.756] Timer tick, asking Buildbucket for the build status
[14:13:14.817] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:74:0) after 1m0s
[14:14:14.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:74:0)
[14:14:14.857] Timer tick, asking Buildbucket for the build status
[14:14:14.917] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:14.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:75:0) after 1m0s
[14:15:14.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:75:0)
[14:15:14.959] Timer tick, asking Buildbucket for the build status
[14:15:15.099] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:15.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:76:0) after 1m0s
[14:16:15.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:76:0)
[14:16:15.119] Timer tick, asking Buildbucket for the build status
[14:16:15.188] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:15.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:77:0) after 1m0s
[14:17:15.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:77:0)
[14:17:15.207] Timer tick, asking Buildbucket for the build status
[14:17:15.311] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:15.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:78:0) after 1m0s
[14:18:15.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:78:0)
[14:18:15.406] Timer tick, asking Buildbucket for the build status
[14:18:15.472] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:79:0) after 1m0s
[14:19:15.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:79:0)
[14:19:15.509] Timer tick, asking Buildbucket for the build status
[14:19:15.858] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:80:0) after 1m0s
[14:20:15.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:80:0)
[14:20:15.921] Timer tick, asking Buildbucket for the build status
[14:20:16.008] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:16.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:81:0) after 1m0s
[14:21:16.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:81:0)
[14:21:16.121] Timer tick, asking Buildbucket for the build status
[14:21:16.316] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:82:0) after 1m0s
[14:22:16.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:82:0)
[14:22:16.418] Timer tick, asking Buildbucket for the build status
[14:22:16.480] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:83:0) after 1m0s
[14:23:16.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:83:0)
[14:23:16.502] Timer tick, asking Buildbucket for the build status
[14:23:16.642] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:16.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:84:0) after 1m0s
[14:24:16.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:84:0)
[14:24:16.666] Timer tick, asking Buildbucket for the build status
[14:24:16.696] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:16.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:85:0) after 1m0s
[14:25:16.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:85:0)
[14:25:16.715] Timer tick, asking Buildbucket for the build status
[14:25:16.787] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:16.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:86:0) after 1m0s
[14:26:16.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:86:0)
[14:26:16.811] Timer tick, asking Buildbucket for the build status
[14:26:16.870] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:16.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:87:0) after 1m0s
[14:27:16.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:87:0)
[14:27:16.890] Timer tick, asking Buildbucket for the build status
[14:27:16.932] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:88:0) after 1m0s
[14:28:16.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:88:0)
[14:28:16.951] Timer tick, asking Buildbucket for the build status
[14:28:17.051] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:89:0) after 1m0s
[14:29:17.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:89:0)
[14:29:17.075] Timer tick, asking Buildbucket for the build status
[14:29:17.139] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:17.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:90:0) after 1m0s
[14:30:17.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:90:0)
[14:30:17.159] Timer tick, asking Buildbucket for the build status
[14:30:17.215] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:91:0) after 1m0s
[14:31:17.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:91:0)
[14:31:17.240] Timer tick, asking Buildbucket for the build status
[14:31:17.306] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:17.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:92:0) after 1m0s
[14:32:17.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:92:0)
[14:32:17.330] Timer tick, asking Buildbucket for the build status
[14:32:17.506] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:17.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:93:0) after 1m0s
[14:33:17.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:93:0)
[14:33:17.603] Timer tick, asking Buildbucket for the build status
[14:33:17.738] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:17.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:94:0) after 1m0s
[14:34:17.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:94:0)
[14:34:17.862] Timer tick, asking Buildbucket for the build status
[14:34:17.903] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:17.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:95:0) after 1m0s
[14:35:18.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:95:0)
[14:35:18.041] Timer tick, asking Buildbucket for the build status
[14:35:18.138] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:18.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:96:0) after 1m0s
[14:36:18.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:96:0)
[14:36:18.162] Timer tick, asking Buildbucket for the build status
[14:36:18.197] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:18.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:97:0) after 1m0s
[14:37:18.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:97:0)
[14:37:18.230] Timer tick, asking Buildbucket for the build status
[14:37:18.292] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:98:0) after 1m0s
[14:38:18.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:98:0)
[14:38:18.350] Timer tick, asking Buildbucket for the build status
[14:38:18.418] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:18.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:99:0) after 1m0s
[14:39:18.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:99:0)
[14:39:18.455] Timer tick, asking Buildbucket for the build status
[14:39:18.876] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:18.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:100:0) after 1m0s
[14:40:18.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:100:0)
[14:40:18.897] Timer tick, asking Buildbucket for the build status
[14:40:18.949] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:18.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:101:0) after 1m0s
[14:41:18.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:101:0)
[14:41:18.975] Timer tick, asking Buildbucket for the build status
[14:41:19.008] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:19.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:102:0) after 1m0s
[14:42:19.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:102:0)
[14:42:19.028] Timer tick, asking Buildbucket for the build status
[14:42:19.069] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:19.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:103:0) after 1m0s
[14:43:19.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:103:0)
[14:43:19.092] Timer tick, asking Buildbucket for the build status
[14:43:19.159] Build 8933956127261519328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:19.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099386189474654080:104:0) after 1m0s
[14:43:26.515] Received PubSub notification, asking Buildbucket for the build status
[14:43:26.585] Build 8933956127261519328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:43:26.586] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1538318605166383",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538312519738057",
"id": "8933956127261519328",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"39046b91a7f47735a6180e056c7ce6bf3cf8ce06\"}}",
"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/8933956127261519328/+/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\": [\"3793-c7dcd56\"], \"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\": \"2ebbdab4bfb1ed9dfe52ce756b34829207dbe25f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"39046b91a7f47735a6180e056c7ce6bf3cf8ce06\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24875}\", \"$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@{#595349}\", \"branch\": \"refs/heads/master\", \"revision\": \"39046b91a7f47735a6180e056c7ce6bf3cf8ce06\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"1ee9160a2e0bc6381caca2b8c42f7ce5507619bc\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"79207e6e11df06880ff0a9071479b2903d46d1b1\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538312519738057, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9099386189474654080\", \"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\": \"8933956127261519328\"}}, \"got_v8_revision\": \"ae37766fa5f1a1c4b57e2905f28664b5f1ae67d6\", \"got_v8_revision_cp\": \"refs/heads/7.1.216@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10249, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"8fd217f2189e07f619e7512cbc81d9e0cc95f4c5\", \"notification_helper_unittests\": \"79d2c449f7d5d969ae83f15e5036ce4ea4f9cd04\", \"gpu_perftests\": \"9b21bc108fe6100468fc0917fc0300ea277873f6\", \"vr_common_unittests\": \"a60075bed99b7e267529e2dcb782ce7d1ce72860\", \"telemetry_unittests\": \"60f72d6a7cb7c9b0760ff06cca2649f8505b1258\", \"load_library_perf_tests\": \"cd9a397025594adfca72920de127a63df16a227f\", \"devtools_closure_compile\": \"47b1e90c378ab4480e13476081e61e888c71bb2f\", \"chromedriver_py_tests\": \"58ae36900680e8723f5e2ae31d40bd1356ba6165\", \"mojo_core_unittests\": \"ff4e2b7d10b4ce2fc80ff024e1a59df658619e48\", \"install_static_unittests\": \"19a34fa22103daa1d3dd9a53fa16429566a158ba\", \"leveldb_service_unittests\": \"caf8538344d02f14727f20ecc1b2ecc661e47e33\", \"mini_installer_tests\": \"b5a94ec72b43a82f9051e49977bf018740f2c8d7\", \"jingle_unittests\": \"73755fa1ce38b891eaac273d2d6a22521cde9968\", \"sbox_integration_tests\": \"74115a2b190de5200a1fab348dc3952a262699ce\", \"angle_unittests\": \"7b585b4d4d1e33540dc926a09ac683521a5fe6a2\", \"cast_unittests\": \"912f73a4673b0c0e096555199fbe5b2850f055fb\", \"cc_unittests\": \"88cfab7a8eb89c391807fa6d79c7f330ab42a548\", \"blink_common_unittests\": \"8be34d681b132f13cceaec599846ddd4a8d03af1\", \"crashpad_tests\": \"3817c8acc79062efe73e2a0cef85d54f93786f24\", \"telemetry_perf_tests_without_chrome\": \"7988a3803cc7affb4eb3307545b4b443965c3be1\", \"metrics_python_tests\": \"f95b0e49247ef3a6ca3e61b77ec9e90ea94bdf49\", \"message_center_unittests\": \"e4f1639b8f5b483fcac5adab37c19e1eb333a564\", \"ppapi_unittests\": \"43bd2deaa32add365fd3e326c634d24b045648c5\", \"extensions_unittests\": \"86783f36e058fb7c5e915354a0a6247164d530a1\", \"gl_unittests_ozone\": \"5f832f85d77b7ea808530d00e0da45680c2a8e67\", \"app_shell_unittests\": \"1ac9f436c75e6ea7866b71dddc024fec61e9d991\", \"chrome_app_unittests\": \"3b7f6835fc9a449f08c9f337bf95d99adf50c2bb\", \"gl_unittests\": \"5f832f85d77b7ea808530d00e0da45680c2a8e67\", \"gcm_unit_tests\": \"02170e90b2ad62b3da385de3d497ad6f54250d8c\", \"views_unittests\": \"0cad9fd2859b88d75c05bea14ebd3a3cabc99d55\", \"content_shell_crash_test\": \"20c0e81a8bded4a0d1f0223a2bc3364fc3c72ff5\", \"ui_base_unittests\": \"41f5047834c10eddc4b868ac6669c407ce182ae0\", \"gles2_conform_test\": \"d83e1fe62426e7fb1397def8837b4aba170a2705\", \"cronet_unittests\": \"0db757d5e57c1a790ecb963671a55812264ac708\", \"performance_test_suite\": \"1872ae5b20fd867001d48cccce9412db0b0e4112\", \"wm_unittests\": \"742aa148ac00bbf1b39aa00e3b9817cf6c74acb1\", \"boringssl_crypto_tests\": \"9586c7c633ea9bfeb831cb37c1c2da88d26c847b\", \"gin_unittests\": \"1b63ba9961ba6df08e8bec4c2849668345bc056b\", \"performance_browser_tests\": \"e00e4fd3b64f79441da77be460cdd84a245d72f7\", \"extensions_browsertests\": \"7b1f7ca8626b08e15dee6940c1e412552046d464\", \"webkit_python_tests\": \"58bc7fb9a25b1b59be5f58c85ad5f8d0edf17dfe\", \"headless_unittests\": \"d24c5a727d089a17626039f73753c976ab52806e\", \"webkit_layout_tests\": \"3d8a39fbeebdbf12108839a9476d68c930e95f84\", \"vr_pixeltests\": \"2308a6d4680a8794adfbc7544185a9cd99ce0f65\", \"setup_unittests\": \"67c39e30e15297f09d40e5b68d697a672ca22a19\", \"webkit_unit_tests\": \"e5ec0103c7d380f0138433a7d9417e8e9cc00b64\", \"content_unittests\": \"91521d185dee6caf35e9a1fbf617216cb7fb9b35\", \"performance_webview_test_suite\": \"ea9f8ad6b9be19942598ef9036d0d2cd3a995731\", \"wtf_unittests\": \"aab7f8f0d2ef34ead6b8737ad41d180e4b436fc9\", \"webkit_layout_tests_exparchive\": \"af7a4d63de561fa8a6e8041f42188c402d2c79ee\", \"chrome_cleaner_unittests\": \"4ce4767c279f04e1bcb6a9d3df9e3149b72d7ef1\", \"traffic_annotation_auditor_unittests\": \"4a1f1090a07d5655d50b45e85f162e4a52d1af25\", \"libjingle_xmpp_unittests\": \"86959065ea778de1dca8bddb86ae8116796cc2d9\", \"remoting_unittests\": \"03c97e95c91f9518dfbdbbc98d962240d5a24043\", \"vr_common_perftests\": \"4c8e9d655cf0418010de7354c027b1d72ae5c964\", \"filesystem_service_unittests\": \"9da65b026e9bd791e35cfa4f6ca9c47e1d7b34f2\", \"chrome_elf_import_unittests\": \"ce999ca5a5dd0c939823b22bfdfe2d99b3276d80\", \"installer_util_unittests\": \"505974d152085f66e5577f730a5b00391b1f765b\", \"gfx_unittests\": \"40893f9f4e0e05c460152226d8ba230b3de90a54\", \"headless_browsertests\": \"1c8935d6cbfc0c8f5e151199fa6ab1e9efd1adba\", \"capture_unittests\": \"887e0b4d4226f91c1bc90f86aa942ec93085241e\", \"chrome_elf_unittests\": \"0a5b992bec2c8753b66c58e1b8535c8b236f21e1\", \"telemetry_gpu_unittests\": \"467b65ba18331a11970ae9c4fbc3524f19666c98\", \"command_buffer_perftests\": \"5674b03092562385c50fa67b87da6b65b4e352c4\", \"media_unittests\": \"8a546cb76a989242a47cae63085826c8fa23d851\", \"chromedriver_unittests\": \"1241a9b74c67f62258d36d1b441e0c5a963fd01e\", \"views_mus_interactive_ui_tests\": \"ebd74c5f3aed63e92219351d67bf172a579729bb\", \"storage_unittests\": \"a38fabfd8daa68567b4c9b84be9a24029f52d16e\", \"media_service_unittests\": \"6fa793bbf2a162fd6a9fc0ffc04125ced279021b\", \"compositor_unittests\": \"0868f4f56651985f36e05824b853ab81a8dc3351\", \"latency_unittests\": \"fc07cd2d2399f138ae1167f341a8799070f45765\", \"video_decode_accelerator_unittest\": \"175d6599907fe4dc759d9dff73758294eae88a2e\", \"swiftshader_unittests\": \"3215d7f389f1414702f29d93246237cc5ed9956d\", \"telemetry_perf_unittests\": \"1446478134ca733374ea6a0ac93e289bf8bdbdba\", \"media_blink_unittests\": \"0e2e9872b7828303abf2f4888afa7d0f8c136dac\", \"views_mus_unittests\": \"70f0400a0bf3f8c526814cf8817a85d9068805e2\", \"components_unittests\": \"32733b5ec63ef5dd43eb3d68670084e614bd3420\", \"snapshot_unittests\": \"25799f153eb43204ee40829d202f2b395d189811\", \"accessibility_unittests\": \"559c303d8f8583c9f7bb01eaa15d9053f7df047e\", \"net_perftests\": \"7c10368ce02f871ba4b6ab2e5f405cc092079f6b\", \"aura_unittests\": \"0d701902ffaf62ffcc00666c403d94690f613f58\", \"services_unittests\": \"4789193612eea49f1de4e1f42601b88eee523d96\", \"components_perftests\": \"49994c622a64823c5ae5e742f23287600315cd20\", \"events_unittests\": \"4ac397de127ad40c2a1cf947533a2dce0e7f7b18\", \"tracing_perftests\": \"a73f934a951bb56bf28054e3f8a172ead667b88a\", \"chromedriver_replay_unittests\": \"50c6aef6c493544165526b2b516579428eb4b618\", \"ui_touch_selection_unittests\": \"d7dde74e7885e4110a625a82d0e09512675809c0\", \"cacheinvalidation_unittests\": \"ea660eb18ec0d16c6da9759d386b512742397924\", \"viz_unittests\": \"37095e4a22615ddacf68109017daa8edcdd87751\", \"browser_tests\": \"59a30f2dadfe026c96f61503b3a9262ba970eeb0\", \"net_unittests\": \"ed6c6882dfa4d8d0160bfd62731f295aeaef788a\", \"midi_unittests\": \"f74d5c8d0aed098ae1d0eb038990c246e1f555c5\", \"boringssl_ssl_tests\": \"100e3ea281b8cdbcb4128b9a9e30b3afef0f3de0\", \"sbox_validation_tests\": \"a87ee11fb6fc963031d4eb12d07faac6855a2a01\", \"elevation_service_unittests\": \"1e638a9816b683fbf32fc37fc1cf2892c9854d24\", \"gpu_unittests\": \"da17dc541e91a182321edf70bf2a71321bc3740d\", \"native_theme_unittests\": \"7b9816040ddd12b55589cd76985c089105107351\", \"interactive_ui_tests\": \"274ea7a18699e2b95125ba15229f5d6be969b113\", \"mojo_unittests\": \"05574427dc7c2308de7fc598b05fcbdd761fb0dd\", \"url_unittests\": \"18f82182a87727c02708ce5e894958281416d43b\", \"media_perftests\": \"7ff228830ed48240379fd6b19060b135a44bafdd\", \"cronet_tests\": \"d800ec6a0c84c175cab03b980faec4084be3b230\", \"google_apis_unittests\": \"59392252036298240e8a13685b9b217f84a2eebc\", \"telemetry_gpu_integration_test\": \"1a0ed7f3287fd9b31e0692715f65aa06cdc6ad9d\", \"blink_heap_unittests\": \"b5b4bf84a4e9e3bc0db263b1fc356b471059ff4a\", \"base_unittests\": \"585e8d2d1a59f1d7588a0393442cc00309d98b26\", \"sync_integration_tests\": \"e0c83d099af7e0a87b459881d8463e812c3ff368\", \"sql_unittests\": \"6ef5ec0b984c77d3244a576d56a7a24ab7c31e7c\", \"courgette_unittests\": \"732de7fc3a356b0b3b8cc7869a65f36721f63965\", \"blink_fuzzer_unittests\": \"7ef9921db321518f25ec90b51afdd07075f4c418\", \"gl_tests\": \"543c2c92c36d81b78ea4f65a6458cdfc2172e453\", \"zucchini_unittests\": \"7f217fd7ac545e379d27baf2fe8cd47afdfb9605\", \"ipc_tests\": \"891bef7439f2873ab8cb746db00ea367a9881c73\", \"angle_end2end_tests\": \"4c63c956d6e4513bc8c416431ed08936a418053a\", \"blink_platform_unittests\": \"e191afb8fe6d005e66c15ee04f2c92672534bdc2\", \"components_browsertests\": \"ab8160cdba3d91913af747b9cfeecb90874265f9\", \"views_perftests\": \"fd0eb60a81cc27d9ee3c6b833955c5d50963d191\", \"angle_perftests\": \"3f1afc9b83d41f03f18def00563724d40ec0510b\", \"display_unittests\": \"8ee31b2d13e4191360e686b910307e9b7b98a2af\", \"sbox_unittests\": \"d77d22016ba8a6d1da09f2c9846422db161699df\", \"service_manager_unittests\": \"a68618fc26abad8f4862b323b99423bca77647b3\", \"pdf_unittests\": \"df4aa64d97264e8e3ea083c9333636889d99bf6f\", \"skia_unittests\": \"84a822736229a60a0dab0a0d7d058047e1feda5d\", \"angle_white_box_tests\": \"cde1848b4b02500343b2ab16fd7eb203d5635d9e\", \"crypto_unittests\": \"1f02511a73c752fa3d805b2aae0dbe01033b8242\", \"nacl_loader_unittests\": \"7b51f0d0ed0f72fbfce11da3f99f9a9adee4290e\", \"unit_tests\": \"e39651f61addf5d038c76267716466e4185c99bd\", \"content_browsertests\": \"2820574fc71be0fdea34bee3b7ec0ba4de48e245\", \"printing_unittests\": \"4c0f960581c0b4357aab22e477be7bfb9e4dd823\", \"device_unittests\": \"31fd24a011858827024f69e9f5882c264d8a05b7\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538312525068847",
"status": "COMPLETED",
"status_changed_ts": "1538318605854958",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10249",
"builder:Windows deterministic",
"buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099386189474654080",
"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/10249",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933956127261519328",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39046b91a7f47735a6180e056c7ce6bf3cf8ce06",
"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/8933956127261519328/+/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:9099386189474654080",
"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:216ff455080a4f94ea455f4ef2ee62b8417f1092",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:404363d5e9690d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1538318605856733",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10249",
"utcnow_ts": "1538318606538555"
}
}
[14:43:26.586] Invocation finished in 1h41m28.34123153s with status SUCCEEDED