[16:49:56.695] New invocation is queued and will start shortly
[16:49:57.937] Starting the invocation (attempt 1)
[16:49:57.974] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:49:57.974] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:49:57.975] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9095747967939453920",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1c8c6f7ecd6a1927225c2257544c6d370441854f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9095747967939453920",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"gitiles_ref:refs/heads/master"
]
}
[16:49:59.906] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541782198165914",
"id": "8930317905735289280",
"lease_expiration_ts": "1541900999608375",
"lease_key": "1774237945",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1c8c6f7ecd6a1927225c2257544c6d370441854f\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1541782199793492",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10680",
"builder:Windows deterministic",
"buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095747967939453920",
"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/10680",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930317905735289280",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:07cf985bf9b48c12ac1d4a614dc409fd274dc3f1",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"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/8930317905735289280/+/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:9095747967939453920",
"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:07cf985bf9b48c12ac1d4a614dc409fd274dc3f1",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:411232e45a08af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1541782199793673",
"url": "https://ci.chromium.org/b/8930317905735289280",
"utcnow_ts": "1541782199892646"
}
}
[16:49:59.906] Task URL: https://ci.chromium.org/b/8930317905735289280
[16:49:59.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:2:0) after 1m0s
[16:50:59.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:2:0)
[16:50:59.955] Timer tick, asking Buildbucket for the build status
[16:51:00.021] Build 8930317905735289280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:00.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:3:0) after 1m0s
[16:51:54.421] Received PubSub notification, asking Buildbucket for the build status
[16:51:54.460] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:00.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:3:0)
[16:52:00.137] Timer tick, asking Buildbucket for the build status
[16:52:00.234] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:5:0) after 1m0s
[16:53:00.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:5:0)
[16:53:00.252] Timer tick, asking Buildbucket for the build status
[16:53:00.292] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:00.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:6:0) after 1m0s
[16:54:00.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:6:0)
[16:54:00.314] Timer tick, asking Buildbucket for the build status
[16:54:00.362] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:00.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:7:0) after 1m0s
[16:55:00.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:7:0)
[16:55:00.425] Timer tick, asking Buildbucket for the build status
[16:55:00.479] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:00.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:8:0) after 1m0s
[16:56:00.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:8:0)
[16:56:00.499] Timer tick, asking Buildbucket for the build status
[16:56:00.584] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:00.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:9:0) after 1m0s
[16:57:00.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:9:0)
[16:57:00.638] Timer tick, asking Buildbucket for the build status
[16:57:00.695] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:10:0) after 1m0s
[16:58:00.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:10:0)
[16:58:00.718] Timer tick, asking Buildbucket for the build status
[16:58:00.789] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:00.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:11:0) after 1m0s
[16:59:00.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:11:0)
[16:59:00.808] Timer tick, asking Buildbucket for the build status
[16:59:00.884] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:00.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:12:0) after 1m0s
[17:00:00.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:12:0)
[17:00:00.969] Timer tick, asking Buildbucket for the build status
[17:00:01.092] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:01.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:13:0) after 1m0s
[17:01:01.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:13:0)
[17:01:01.111] Timer tick, asking Buildbucket for the build status
[17:01:01.146] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:01.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:14:0) after 1m0s
[17:02:01.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:14:0)
[17:02:01.169] Timer tick, asking Buildbucket for the build status
[17:02:01.208] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:01.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:15:0) after 1m0s
[17:03:01.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:15:0)
[17:03:01.238] Timer tick, asking Buildbucket for the build status
[17:03:01.509] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:01.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:16:0) after 1m0s
[17:04:01.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:16:0)
[17:04:01.526] Timer tick, asking Buildbucket for the build status
[17:04:01.625] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:01.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:17:0) after 1m0s
[17:05:01.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:17:0)
[17:05:01.644] Timer tick, asking Buildbucket for the build status
[17:05:01.796] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:18:0) after 1m0s
[17:06:01.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:18:0)
[17:06:01.821] Timer tick, asking Buildbucket for the build status
[17:06:01.866] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:01.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:19:0) after 1m0s
[17:07:01.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:19:0)
[17:07:01.885] Timer tick, asking Buildbucket for the build status
[17:07:02.467] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:02.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:20:0) after 1m0s
[17:08:02.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:20:0)
[17:08:02.491] Timer tick, asking Buildbucket for the build status
[17:08:02.634] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:02.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:21:0) after 1m0s
[17:09:02.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:21:0)
[17:09:02.696] Timer tick, asking Buildbucket for the build status
[17:09:02.848] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:02.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:22:0) after 1m0s
[17:10:02.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:22:0)
[17:10:02.865] Timer tick, asking Buildbucket for the build status
[17:10:02.900] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:02.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:23:0) after 1m0s
[17:11:02.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:23:0)
[17:11:02.927] Timer tick, asking Buildbucket for the build status
[17:11:02.959] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:24:0) after 1m0s
[17:12:03.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:24:0)
[17:12:03.001] Timer tick, asking Buildbucket for the build status
[17:12:03.144] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:03.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:25:0) after 1m0s
[17:13:03.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:25:0)
[17:13:03.217] Timer tick, asking Buildbucket for the build status
[17:13:03.308] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:03.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:26:0) after 1m0s
[17:14:03.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:26:0)
[17:14:03.329] Timer tick, asking Buildbucket for the build status
[17:14:03.395] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:03.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:27:0) after 1m0s
[17:15:03.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:27:0)
[17:15:03.422] Timer tick, asking Buildbucket for the build status
[17:15:03.575] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:03.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:28:0) after 1m0s
[17:16:03.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:28:0)
[17:16:03.600] Timer tick, asking Buildbucket for the build status
[17:16:03.690] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:03.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:29:0) after 1m0s
[17:17:03.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:29:0)
[17:17:03.802] Timer tick, asking Buildbucket for the build status
[17:17:03.859] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:03.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:30:0) after 1m0s
[17:18:03.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:30:0)
[17:18:03.883] Timer tick, asking Buildbucket for the build status
[17:18:03.929] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:03.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:31:0) after 1m0s
[17:19:03.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:31:0)
[17:19:03.952] Timer tick, asking Buildbucket for the build status
[17:19:04.017] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:04.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:32:0) after 1m0s
[17:20:04.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:32:0)
[17:20:04.054] Timer tick, asking Buildbucket for the build status
[17:20:04.117] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:33:0) after 1m0s
[17:21:04.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:33:0)
[17:21:04.173] Timer tick, asking Buildbucket for the build status
[17:21:04.252] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:04.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:34:0) after 1m0s
[17:22:04.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:34:0)
[17:22:04.475] Timer tick, asking Buildbucket for the build status
[17:22:04.535] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:04.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:35:0) after 1m0s
[17:23:04.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:35:0)
[17:23:04.561] Timer tick, asking Buildbucket for the build status
[17:23:05.133] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:05.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:36:0) after 1m0s
[17:24:05.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:36:0)
[17:24:05.152] Timer tick, asking Buildbucket for the build status
[17:24:05.234] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:05.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:37:0) after 1m0s
[17:25:05.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:37:0)
[17:25:05.252] Timer tick, asking Buildbucket for the build status
[17:25:05.551] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:05.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:38:0) after 1m0s
[17:26:05.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:38:0)
[17:26:05.590] Timer tick, asking Buildbucket for the build status
[17:26:05.636] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:05.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:39:0) after 1m0s
[17:27:05.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:39:0)
[17:27:05.656] Timer tick, asking Buildbucket for the build status
[17:27:05.733] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:05.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:40:0) after 1m0s
[17:28:05.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:40:0)
[17:28:05.752] Timer tick, asking Buildbucket for the build status
[17:28:05.789] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:41:0) after 1m0s
[17:29:05.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:41:0)
[17:29:05.813] Timer tick, asking Buildbucket for the build status
[17:29:05.955] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:05.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:42:0) after 1m0s
[17:30:05.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:42:0)
[17:30:05.994] Timer tick, asking Buildbucket for the build status
[17:30:06.066] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:06.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:43:0) after 1m0s
[17:31:06.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:43:0)
[17:31:06.135] Timer tick, asking Buildbucket for the build status
[17:31:06.368] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:06.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:44:0) after 1m0s
[17:32:06.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:44:0)
[17:32:06.393] Timer tick, asking Buildbucket for the build status
[17:32:06.435] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:06.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:45:0) after 1m0s
[17:33:06.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:45:0)
[17:33:06.464] Timer tick, asking Buildbucket for the build status
[17:33:06.498] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:06.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:46:0) after 1m0s
[17:34:06.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:46:0)
[17:34:06.518] Timer tick, asking Buildbucket for the build status
[17:34:06.555] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:06.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:47:0) after 1m0s
[17:35:06.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:47:0)
[17:35:06.593] Timer tick, asking Buildbucket for the build status
[17:35:06.677] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:06.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:48:0) after 1m0s
[17:36:06.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:48:0)
[17:36:06.707] Timer tick, asking Buildbucket for the build status
[17:36:06.756] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:06.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:49:0) after 1m0s
[17:37:06.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:49:0)
[17:37:06.878] Timer tick, asking Buildbucket for the build status
[17:37:06.969] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:06.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:50:0) after 1m0s
[17:38:06.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:50:0)
[17:38:06.995] Timer tick, asking Buildbucket for the build status
[17:38:07.085] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:07.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:51:0) after 1m0s
[17:39:07.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:51:0)
[17:39:07.109] Timer tick, asking Buildbucket for the build status
[17:39:07.156] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:07.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:52:0) after 1m0s
[17:40:07.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:52:0)
[17:40:07.177] Timer tick, asking Buildbucket for the build status
[17:40:07.241] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:07.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:53:0) after 1m0s
[17:41:07.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:53:0)
[17:41:07.261] Timer tick, asking Buildbucket for the build status
[17:41:07.299] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:07.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:54:0) after 1m0s
[17:42:07.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:54:0)
[17:42:07.385] Timer tick, asking Buildbucket for the build status
[17:42:07.423] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:55:0) after 1m0s
[17:43:07.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:55:0)
[17:43:07.450] Timer tick, asking Buildbucket for the build status
[17:43:07.541] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:07.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:56:0) after 1m0s
[17:44:07.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:56:0)
[17:44:07.658] Timer tick, asking Buildbucket for the build status
[17:44:07.717] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:07.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:57:0) after 1m0s
[17:45:07.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:57:0)
[17:45:07.740] Timer tick, asking Buildbucket for the build status
[17:45:07.781] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:07.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:58:0) after 1m0s
[17:46:07.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:58:0)
[17:46:07.853] Timer tick, asking Buildbucket for the build status
[17:46:07.933] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:07.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:59:0) after 1m0s
[17:47:08.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:59:0)
[17:47:08.071] Timer tick, asking Buildbucket for the build status
[17:47:08.105] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:08.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:60:0) after 1m0s
[17:48:08.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:60:0)
[17:48:08.135] Timer tick, asking Buildbucket for the build status
[17:48:08.275] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:08.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:61:0) after 1m0s
[17:49:08.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:61:0)
[17:49:08.314] Timer tick, asking Buildbucket for the build status
[17:49:08.370] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:62:0) after 1m0s
[17:50:08.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:62:0)
[17:50:08.391] Timer tick, asking Buildbucket for the build status
[17:50:08.458] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:08.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:63:0) after 1m0s
[17:51:08.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:63:0)
[17:51:08.481] Timer tick, asking Buildbucket for the build status
[17:51:08.534] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:08.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:64:0) after 1m0s
[17:52:08.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:64:0)
[17:52:08.567] Timer tick, asking Buildbucket for the build status
[17:52:08.620] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:08.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:65:0) after 1m0s
[17:53:08.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:65:0)
[17:53:08.640] Timer tick, asking Buildbucket for the build status
[17:53:08.692] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:66:0) after 1m0s
[17:54:08.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:66:0)
[17:54:08.712] Timer tick, asking Buildbucket for the build status
[17:54:08.776] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:67:0) after 1m0s
[17:55:08.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:67:0)
[17:55:08.800] Timer tick, asking Buildbucket for the build status
[17:55:08.838] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:08.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:68:0) after 1m0s
[17:56:08.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:68:0)
[17:56:08.877] Timer tick, asking Buildbucket for the build status
[17:56:08.950] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:08.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:69:0) after 1m0s
[17:57:09.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:69:0)
[17:57:09.011] Timer tick, asking Buildbucket for the build status
[17:57:09.076] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:09.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:70:0) after 1m0s
[17:58:09.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:70:0)
[17:58:09.098] Timer tick, asking Buildbucket for the build status
[17:58:09.219] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:09.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:71:0) after 1m0s
[17:59:09.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:71:0)
[17:59:09.260] Timer tick, asking Buildbucket for the build status
[17:59:09.316] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:09.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:72:0) after 1m0s
[18:00:09.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:72:0)
[18:00:09.337] Timer tick, asking Buildbucket for the build status
[18:00:09.385] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:09.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:73:0) after 1m0s
[18:01:09.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:73:0)
[18:01:09.407] Timer tick, asking Buildbucket for the build status
[18:01:09.448] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:09.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:74:0) after 1m0s
[18:02:09.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:74:0)
[18:02:09.470] Timer tick, asking Buildbucket for the build status
[18:02:09.534] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:75:0) after 1m0s
[18:03:09.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:75:0)
[18:03:09.605] Timer tick, asking Buildbucket for the build status
[18:03:09.695] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:09.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:76:0) after 1m0s
[18:04:09.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:76:0)
[18:04:09.718] Timer tick, asking Buildbucket for the build status
[18:04:09.843] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:09.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:77:0) after 1m0s
[18:05:09.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:77:0)
[18:05:09.865] Timer tick, asking Buildbucket for the build status
[18:05:09.904] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:09.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:78:0) after 1m0s
[18:06:09.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:78:0)
[18:06:09.929] Timer tick, asking Buildbucket for the build status
[18:06:09.999] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:09.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:79:0) after 1m0s
[18:07:10.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:79:0)
[18:07:10.081] Timer tick, asking Buildbucket for the build status
[18:07:10.155] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:10.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:80:0) after 1m0s
[18:08:10.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:80:0)
[18:08:10.193] Timer tick, asking Buildbucket for the build status
[18:08:10.268] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:10.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:81:0) after 1m0s
[18:09:10.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:81:0)
[18:09:10.296] Timer tick, asking Buildbucket for the build status
[18:09:10.356] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:10.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:82:0) after 1m0s
[18:10:10.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:82:0)
[18:10:10.377] Timer tick, asking Buildbucket for the build status
[18:10:10.435] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:10.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:83:0) after 1m0s
[18:11:10.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:83:0)
[18:11:10.488] Timer tick, asking Buildbucket for the build status
[18:11:10.592] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:10.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:84:0) after 1m0s
[18:12:10.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:84:0)
[18:12:10.629] Timer tick, asking Buildbucket for the build status
[18:12:10.845] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:10.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:85:0) after 1m0s
[18:13:10.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:85:0)
[18:13:10.877] Timer tick, asking Buildbucket for the build status
[18:13:10.914] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:10.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:86:0) after 1m0s
[18:14:10.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:86:0)
[18:14:10.937] Timer tick, asking Buildbucket for the build status
[18:14:11.009] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:11.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:87:0) after 1m0s
[18:15:11.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:87:0)
[18:15:11.031] Timer tick, asking Buildbucket for the build status
[18:15:11.072] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:11.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:88:0) after 1m0s
[18:16:11.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:88:0)
[18:16:11.098] Timer tick, asking Buildbucket for the build status
[18:16:11.167] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:89:0) after 1m0s
[18:17:11.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:89:0)
[18:17:11.193] Timer tick, asking Buildbucket for the build status
[18:17:11.238] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:11.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:90:0) after 1m0s
[18:18:11.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:90:0)
[18:18:11.276] Timer tick, asking Buildbucket for the build status
[18:18:11.334] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:91:0) after 1m0s
[18:19:11.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:91:0)
[18:19:11.357] Timer tick, asking Buildbucket for the build status
[18:19:11.400] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:11.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:92:0) after 1m0s
[18:20:11.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:92:0)
[18:20:11.422] Timer tick, asking Buildbucket for the build status
[18:20:11.473] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:11.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:93:0) after 1m0s
[18:21:11.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:93:0)
[18:21:11.498] Timer tick, asking Buildbucket for the build status
[18:21:11.532] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:11.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:94:0) after 1m0s
[18:22:11.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:94:0)
[18:22:11.553] Timer tick, asking Buildbucket for the build status
[18:22:11.806] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:11.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:95:0) after 1m0s
[18:23:11.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:95:0)
[18:23:11.832] Timer tick, asking Buildbucket for the build status
[18:23:11.921] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:11.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:96:0) after 1m0s
[18:24:11.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:96:0)
[18:24:11.945] Timer tick, asking Buildbucket for the build status
[18:24:12.026] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:12.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:97:0) after 1m0s
[18:25:12.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:97:0)
[18:25:12.104] Timer tick, asking Buildbucket for the build status
[18:25:12.226] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:12.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:98:0) after 1m0s
[18:26:12.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:98:0)
[18:26:12.248] Timer tick, asking Buildbucket for the build status
[18:26:12.364] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:12.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:99:0) after 1m0s
[18:27:12.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:99:0)
[18:27:12.389] Timer tick, asking Buildbucket for the build status
[18:27:12.473] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:12.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:100:0) after 1m0s
[18:28:12.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:100:0)
[18:28:12.496] Timer tick, asking Buildbucket for the build status
[18:28:12.558] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:12.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:101:0) after 1m0s
[18:29:12.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:101:0)
[18:29:12.597] Timer tick, asking Buildbucket for the build status
[18:29:12.686] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:12.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:102:0) after 1m0s
[18:30:12.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:102:0)
[18:30:12.717] Timer tick, asking Buildbucket for the build status
[18:30:12.771] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:12.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:103:0) after 1m0s
[18:31:12.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:103:0)
[18:31:12.803] Timer tick, asking Buildbucket for the build status
[18:31:12.893] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:12.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:104:0) after 1m0s
[18:32:12.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:104:0)
[18:32:12.999] Timer tick, asking Buildbucket for the build status
[18:32:13.064] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:13.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:105:0) after 1m0s
[18:33:13.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:105:0)
[18:33:13.136] Timer tick, asking Buildbucket for the build status
[18:33:13.219] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:13.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:106:0) after 1m0s
[18:34:13.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:106:0)
[18:34:13.338] Timer tick, asking Buildbucket for the build status
[18:34:13.694] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:13.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:107:0) after 1m0s
[18:35:13.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:107:0)
[18:35:13.722] Timer tick, asking Buildbucket for the build status
[18:35:13.787] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:13.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:108:0) after 1m0s
[18:36:13.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:108:0)
[18:36:13.809] Timer tick, asking Buildbucket for the build status
[18:36:13.878] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:13.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:109:0) after 1m0s
[18:37:13.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:109:0)
[18:37:13.901] Timer tick, asking Buildbucket for the build status
[18:37:13.961] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:13.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:110:0) after 1m0s
[18:38:13.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:110:0)
[18:38:13.984] Timer tick, asking Buildbucket for the build status
[18:38:14.096] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:111:0) after 1m0s
[18:39:14.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:111:0)
[18:39:14.188] Timer tick, asking Buildbucket for the build status
[18:39:14.309] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:14.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:112:0) after 1m0s
[18:40:14.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:112:0)
[18:40:14.335] Timer tick, asking Buildbucket for the build status
[18:40:14.378] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:14.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:113:0) after 1m0s
[18:41:14.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:113:0)
[18:41:14.413] Timer tick, asking Buildbucket for the build status
[18:41:14.823] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:114:0) after 1m0s
[18:42:14.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:114:0)
[18:42:14.854] Timer tick, asking Buildbucket for the build status
[18:42:14.935] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:14.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:115:0) after 1m0s
[18:43:15.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:115:0)
[18:43:15.036] Timer tick, asking Buildbucket for the build status
[18:43:15.092] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:15.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:116:0) after 1m0s
[18:44:15.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:116:0)
[18:44:15.203] Timer tick, asking Buildbucket for the build status
[18:44:15.282] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:15.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:117:0) after 1m0s
[18:45:15.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:117:0)
[18:45:15.321] Timer tick, asking Buildbucket for the build status
[18:45:15.356] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:15.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:118:0) after 1m0s
[18:46:15.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:118:0)
[18:46:15.382] Timer tick, asking Buildbucket for the build status
[18:46:15.460] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:15.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:119:0) after 1m0s
[18:47:15.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:119:0)
[18:47:15.481] Timer tick, asking Buildbucket for the build status
[18:47:15.590] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:15.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:120:0) after 1m0s
[18:48:15.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:120:0)
[18:48:15.614] Timer tick, asking Buildbucket for the build status
[18:48:15.705] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:15.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:121:0) after 1m0s
[18:49:15.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:121:0)
[18:49:15.728] Timer tick, asking Buildbucket for the build status
[18:49:15.766] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:15.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:122:0) after 1m0s
[18:50:15.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:122:0)
[18:50:15.892] Timer tick, asking Buildbucket for the build status
[18:50:15.959] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:15.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:123:0) after 1m0s
[18:51:15.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:123:0)
[18:51:15.987] Timer tick, asking Buildbucket for the build status
[18:51:16.105] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:16.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:124:0) after 1m0s
[18:52:16.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:124:0)
[18:52:16.286] Timer tick, asking Buildbucket for the build status
[18:52:16.410] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:16.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:125:0) after 1m0s
[18:53:16.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:125:0)
[18:53:16.597] Timer tick, asking Buildbucket for the build status
[18:53:16.688] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:16.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:126:0) after 1m0s
[18:54:16.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:126:0)
[18:54:16.736] Timer tick, asking Buildbucket for the build status
[18:54:16.816] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:16.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:127:0) after 1m0s
[18:55:16.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:127:0)
[18:55:16.843] Timer tick, asking Buildbucket for the build status
[18:55:17.009] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:17.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:128:0) after 1m0s
[18:56:17.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:128:0)
[18:56:17.031] Timer tick, asking Buildbucket for the build status
[18:56:17.076] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:17.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:129:0) after 1m0s
[18:57:17.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:129:0)
[18:57:17.103] Timer tick, asking Buildbucket for the build status
[18:57:17.140] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:17.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:130:0) after 1m0s
[18:58:17.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:130:0)
[18:58:17.166] Timer tick, asking Buildbucket for the build status
[18:58:17.241] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:131:0) after 1m0s
[18:59:17.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:131:0)
[18:59:17.264] Timer tick, asking Buildbucket for the build status
[18:59:17.343] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:17.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:132:0) after 1m0s
[19:00:17.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:132:0)
[19:00:17.484] Timer tick, asking Buildbucket for the build status
[19:00:17.553] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:17.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:133:0) after 1m0s
[19:01:17.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:133:0)
[19:01:17.579] Timer tick, asking Buildbucket for the build status
[19:01:17.645] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:17.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:134:0) after 1m0s
[19:02:17.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:134:0)
[19:02:17.672] Timer tick, asking Buildbucket for the build status
[19:02:17.794] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:17.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:135:0) after 1m0s
[19:03:17.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:135:0)
[19:03:17.819] Timer tick, asking Buildbucket for the build status
[19:03:17.925] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:17.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:136:0) after 1m0s
[19:04:17.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:136:0)
[19:04:17.955] Timer tick, asking Buildbucket for the build status
[19:04:17.996] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:17.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:137:0) after 1m0s
[19:05:18.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:137:0)
[19:05:18.033] Timer tick, asking Buildbucket for the build status
[19:05:18.066] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:18.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:138:0) after 1m0s
[19:06:18.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:138:0)
[19:06:18.099] Timer tick, asking Buildbucket for the build status
[19:06:18.224] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:18.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:139:0) after 1m0s
[19:07:18.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:139:0)
[19:07:18.257] Timer tick, asking Buildbucket for the build status
[19:07:18.362] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:18.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:140:0) after 1m0s
[19:08:18.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:140:0)
[19:08:18.393] Timer tick, asking Buildbucket for the build status
[19:08:18.514] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:18.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:141:0) after 1m0s
[19:09:18.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:141:0)
[19:09:18.541] Timer tick, asking Buildbucket for the build status
[19:09:18.581] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:18.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:142:0) after 1m0s
[19:10:18.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:142:0)
[19:10:18.612] Timer tick, asking Buildbucket for the build status
[19:10:18.710] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:18.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:143:0) after 1m0s
[19:11:18.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:143:0)
[19:11:18.748] Timer tick, asking Buildbucket for the build status
[19:11:18.788] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:144:0) after 1m0s
[19:12:18.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:144:0)
[19:12:18.812] Timer tick, asking Buildbucket for the build status
[19:12:18.887] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:18.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:145:0) after 1m0s
[19:13:18.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:145:0)
[19:13:18.929] Timer tick, asking Buildbucket for the build status
[19:13:18.989] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:18.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:146:0) after 1m0s
[19:14:19.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:146:0)
[19:14:19.014] Timer tick, asking Buildbucket for the build status
[19:14:19.126] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:19.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:147:0) after 1m0s
[19:15:19.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:147:0)
[19:15:19.217] Timer tick, asking Buildbucket for the build status
[19:15:19.323] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:19.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:148:0) after 1m0s
[19:16:19.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:148:0)
[19:16:19.361] Timer tick, asking Buildbucket for the build status
[19:16:19.398] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:19.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:149:0) after 1m0s
[19:17:19.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:149:0)
[19:17:19.474] Timer tick, asking Buildbucket for the build status
[19:17:19.522] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:150:0) after 1m0s
[19:18:19.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:150:0)
[19:18:19.568] Timer tick, asking Buildbucket for the build status
[19:18:19.677] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:19.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:151:0) after 1m0s
[19:19:19.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:151:0)
[19:19:19.709] Timer tick, asking Buildbucket for the build status
[19:19:19.751] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:19.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:152:0) after 1m0s
[19:20:19.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:152:0)
[19:20:19.786] Timer tick, asking Buildbucket for the build status
[19:20:19.849] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:19.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:153:0) after 1m0s
[19:21:19.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:153:0)
[19:21:19.878] Timer tick, asking Buildbucket for the build status
[19:21:19.932] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:19.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:154:0) after 1m0s
[19:22:19.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:154:0)
[19:22:19.961] Timer tick, asking Buildbucket for the build status
[19:22:20.112] Build 8930317905735289280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:20.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9095747967939453920:155:0) after 1m0s
[19:22:23.059] Received PubSub notification, asking Buildbucket for the build status
[19:22:23.179] Build 8930317905735289280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:22:23.179] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1541791341930990",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541782198165914",
"id": "8930317905735289280",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1c8c6f7ecd6a1927225c2257544c6d370441854f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3844-124e68f\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"1c8c6f7ecd6a1927225c2257544c6d370441854f\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"2960ec33667a11bb4445dfe8154aef133c741afe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25544}\", \"$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@{#606868}\", \"branch\": \"refs/heads/master\", \"revision\": \"1c8c6f7ecd6a1927225c2257544c6d370441854f\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"e769ed90c3599a131166d5a61625c1b64318fb91\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"5d2dfa46c05c8c661304922ce1e1e7d7b045a342\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1541782198165914, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9095747967939453920\", \"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\": \"8930317905735289280\"}}, \"got_v8_revision\": \"31b2546b348e864539ade15897eac971b3c0e402\", \"got_v8_revision_cp\": \"refs/heads/7.2.286@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10680, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"81b73401f0df1384e1db85a112a52244345942b9\", \"notification_helper_unittests\": \"fa2e6d6ab739ee447ba3867fba4c1e89466f74d1\", \"gpu_perftests\": \"d4e4d17026e215881450fb20ca57f86843e04832\", \"vr_common_unittests\": \"37a0a992dae15db4cbe82cbf97b6836b2dbbb59c\", \"telemetry_unittests\": \"dedd859062f6087f91ea7ab403c02a0756ab4d15\", \"load_library_perf_tests\": \"b2be66acd62e020395868e1456bfd6b396e79bfa\", \"devtools_closure_compile\": \"0a97b0b32bfb2d1df23592728e6cd59c33470d6c\", \"chromedriver_py_tests\": \"994f548e7145a442c7be18b5cdc3a490e8dfc83e\", \"mojo_core_unittests\": \"2165e27570f94b69192333dd23e80553d0c7505c\", \"install_static_unittests\": \"71fd22051f3df7feb7774a07670562ee83e9809f\", \"leveldb_service_unittests\": \"00acfc063e42f72a025b868d42aecd7e3051fc04\", \"mini_installer_tests\": \"0f4bfeef9fa44a432792ce128c7ae67dc5ea7258\", \"gcp_unittests\": \"d860209757f411d6d6275041a0c21cc5ed5daa30\", \"sbox_integration_tests\": \"fe29e98cf0292318ae86d4fa8fa9ea3cf8eb2a97\", \"angle_unittests\": \"8ba4720a99e0dfc3052ae607d5ffc35a47ac6596\", \"cast_unittests\": \"d7294894b30c838579acbdc4aea8c6cb4e12d0ce\", \"cc_unittests\": \"fb694b001b2f09554893ab8492dcd2d4949c58de\", \"blink_common_unittests\": \"d19391586d247842e9da045f5d60f4e84131f640\", \"crashpad_tests\": \"38b1225d2da7787e21215b12fd8bf2432c569ecd\", \"telemetry_perf_tests_without_chrome\": \"de8fddd4e743ca3e43d638e464ac56dbb2cd0c41\", \"metrics_python_tests\": \"e752064845c425b315bbbf6f4006b9307b4aa2dc\", \"message_center_unittests\": \"a14c7b709fa2df0d0edf3a15e291599691da3b1c\", \"ppapi_unittests\": \"6cf3f7ffd322c3a5c691a82dab617cb64d2d4534\", \"extensions_unittests\": \"b59ad69d3f9d68fbbe89bf5515ad9fe2a912ee63\", \"gl_unittests_ozone\": \"42f19256c9c45fa842b38ba48cd7a8d5e7d0c9c3\", \"app_shell_unittests\": \"9866efca37859887c6505a64035954f9687a1fb9\", \"chrome_app_unittests\": \"ac1beaca0d8cea90feb28de1bce94e428a4e5d2c\", \"gl_unittests\": \"42f19256c9c45fa842b38ba48cd7a8d5e7d0c9c3\", \"gcm_unit_tests\": \"3e379650b74e4fad68e434bdd32df05051f4c822\", \"views_unittests\": \"2344ac88c8deb6e1eebc80457693a0a124febb83\", \"content_shell_crash_test\": \"96d172a8749c2d4038e3420ecd39cfc54433ac79\", \"dawn_end2end_tests\": \"226256f8443990fc942fc1a6fb69ff333b1793dd\", \"ui_base_unittests\": \"20d9d17a9fc8dfea20492232d919b5985d484935\", \"gles2_conform_test\": \"5c3c07c0ed5c80d9caff93effaf4d84f7659f258\", \"cronet_unittests\": \"583f5d6e68cdded20bac95b0a663049b0ff34220\", \"performance_test_suite\": \"7764c3d5ea75e254ba8a153b54337494011d8990\", \"wm_unittests\": \"b7c81178c1b050ba7bf66e752cb6f1942952fbf9\", \"boringssl_crypto_tests\": \"45a848975b66488b4d587fce669e8e4c7ccf4276\", \"gin_unittests\": \"552ff17a4e0c2305ef727dafd0b6938a89474b41\", \"performance_browser_tests\": \"9780f9eb235f024f5a2bd03566f90ce673b1cd34\", \"extensions_browsertests\": \"f0648ca24f2b8dcf74a812429e6d5f294a7846ec\", \"webkit_python_tests\": \"5f3540816053b99043f7c9bb9159b6e0297ab93e\", \"headless_unittests\": \"6ea13c99dd7d55676b7032649218c113fc9fd0d1\", \"webkit_layout_tests\": \"02a227e5ed3427f857a51292ef5eead2d3d4ac9a\", \"vr_pixeltests\": \"c73687107352ea51db8e33a44c3fbff493692ad6\", \"setup_unittests\": \"67bc4a0bb9ef872a4f13c70503323f97bf687078\", \"webkit_unit_tests\": \"028d6fca0e88262f9919daa30ea247f899a54176\", \"content_unittests\": \"578b0c26116999f8a915f279f7a9273104978870\", \"performance_webview_test_suite\": \"e4cef360a2b18a93fe1df3e4e3303f5274dd5606\", \"wtf_unittests\": \"cecc6981701a334dd72d4811c9dd4d400de6ea68\", \"webkit_layout_tests_exparchive\": \"a7161399c615a7247045224871f2c6bdc41bd291\", \"chrome_cleaner_unittests\": \"c38dcb4c427aa511c0d2ac8a5d6ef6b3e3792394\", \"traffic_annotation_auditor_unittests\": \"308f6fcbc5dd2d7d55368188aaa30e07c74cbede\", \"libjingle_xmpp_unittests\": \"7abc88696e4c12b9d4638753616a04498bbb03e0\", \"remoting_unittests\": \"7f7b0b1dda1aeb130053c44d68fb898523a352d3\", \"vr_common_perftests\": \"47d3a1612d26572f9406ffebe7552989d1e40d08\", \"filesystem_service_unittests\": \"754fe0ccdcf9450ef4c027599874e326e706dbcd\", \"chrome_elf_import_unittests\": \"f42cb331187f198420b6f72cfeb8d8be2b3a97de\", \"installer_util_unittests\": \"970e17201291eae0e2b32df0bbc6c24c3e973b3c\", \"base_perftests\": \"2bf5199ec4e7074a5a9ee4ed4e92f7654fe824ec\", \"headless_browsertests\": \"d04b76c83a23fc419e92dfed5179d3b6b3553b78\", \"capture_unittests\": \"53ccc6962e9fb10b3ba58a3b64a568466640c433\", \"chrome_elf_unittests\": \"d8232342bafb89a21b66a8041d1cb4f4b04fbd05\", \"telemetry_gpu_unittests\": \"e4c751578719c2bd2eb43b09db1cdaa8baddd387\", \"command_buffer_perftests\": \"7a4a2155b499ace9ad727c47259580cc7549b9ff\", \"media_unittests\": \"c515749456b01a80004cfd853b31e87957f9f015\", \"gfx_unittests\": \"f35e2f5294374e84abaf48a0a8e8cefc64fb6879\", \"chromedriver_unittests\": \"300c20557f287dab016469ba27434c1d1c2d7bdb\", \"views_mus_interactive_ui_tests\": \"c539f029871620de9102721370ec92af62c665b2\", \"storage_unittests\": \"08157964dee0fe31b0d5c03e84fde552926c01d2\", \"media_service_unittests\": \"93b715304ef912f690468f40390a3b10ded657f8\", \"compositor_unittests\": \"d09e8383cee31045a1e7c3ada9ec09d2aaad715e\", \"latency_unittests\": \"d0d67064482d41d6120f2776f59a81d9e1a3700d\", \"video_decode_accelerator_unittest\": \"5794570f12bd21479f548c5dc04babc56d772882\", \"swiftshader_unittests\": \"7af73a962bee33bcae0e81f85a7ada05d30dccc8\", \"telemetry_perf_unittests\": \"0e9cacf3989732c0b035e203fec3a8c680f6f3cb\", \"media_blink_unittests\": \"5759a4ddc7fc642bc54168072dd43df0ea2df21f\", \"views_mus_unittests\": \"860427fac7330d1ec45282d9358d9d06ca111311\", \"components_unittests\": \"c8dbdd6f618d94b01f15e2d5dc1db9cc616bfe3a\", \"snapshot_unittests\": \"d2d2a23914a9dc78bef338dda1c8e2c5c25cb404\", \"accessibility_unittests\": \"f43cced06182705f0cc237269579e1867792fd53\", \"net_perftests\": \"465bdfd337cd8ed5309ba9e4b5139c7426cf1a36\", \"aura_unittests\": \"48af7d5d025fa3ee4693044dd74c638dd62941d4\", \"services_unittests\": \"40e99b7a958ae59355e37d5aa3cff14c94a7358f\", \"components_perftests\": \"2d43237b7861c4a4965921274e4f5e698419f3bf\", \"events_unittests\": \"e8cd1c60343ad5720a79cf7218ec1a6dc045ed04\", \"tracing_perftests\": \"0984c9570f658cb207c962b1c63491a2772456f4\", \"chromedriver_replay_unittests\": \"4bd1faf821fce24d79157820b7b7cd3ac2473ff6\", \"ui_touch_selection_unittests\": \"df936b676cac58cef36d33c7f96c5e9e602469de\", \"cacheinvalidation_unittests\": \"d7ae79261790a4a4fa9598243ee8c0a453ba43d9\", \"viz_unittests\": \"6f18e5ad55b3f430f5c1c5099f377e031a187fcd\", \"browser_tests\": \"7c483520d2cce555ddc45709a5909eb1558b8687\", \"net_unittests\": \"14774f3dec3dc35963307f89d26b9c5db8a305c3\", \"midi_unittests\": \"7e9e7f6da21c9bfef354ddea52731de18b7a62a4\", \"boringssl_ssl_tests\": \"0b5b1840ed3cab210cfb36ad08064d33d52d31f8\", \"sbox_validation_tests\": \"0554c2c56db46058643c05b8c402f4ed1cf76936\", \"elevation_service_unittests\": \"11e973eb35b96a6bf395bf544c010c338098d2df\", \"gpu_unittests\": \"fff4e315979be8dff83e1338bba1228c70d06811\", \"native_theme_unittests\": \"0d6736fee398039927a12be5025104697571b2d6\", \"interactive_ui_tests\": \"05a31e3e0953127367319913bd279bab48b73083\", \"mojo_unittests\": \"b7c832b62973f6dc8d9ccb6043ade7613b7fb788\", \"url_unittests\": \"e7878506c99e14cb95a8cd35d9c391acab3ee215\", \"media_perftests\": \"11ecb0ac1b0856ba9b45746cda05aa265aff7d9e\", \"cronet_tests\": \"7f7645a8a693acc82fccd56209ea62e5ba3e523a\", \"google_apis_unittests\": \"4d73c64ef07bf82d96503a034448af9b2b509624\", \"telemetry_gpu_integration_test\": \"894627e96e8729e0381bd3bcb663b27710d088a5\", \"blink_heap_unittests\": \"f2893a32cec517ffe3c7695d6ccba9879426d3cf\", \"base_unittests\": \"6964301ba10552a59b9cd218b8492f39f0868ffe\", \"sync_integration_tests\": \"5796f78c6f35f3cf489de148a22f213b5dfc9004\", \"sql_unittests\": \"f203c7646dbb8a522c52c37a4d3511f481bcaa89\", \"courgette_unittests\": \"e5fe19538fd90f0f257bcad8ae763499efe9374a\", \"blink_fuzzer_unittests\": \"449b9f4d630d0977fc7145c649ef90ea5e68c66a\", \"gl_tests\": \"aebbef2af63dfc161f17278021924356c0d81cb3\", \"zucchini_unittests\": \"73e0963785fde5ea538da96ab67b55560c30e256\", \"ipc_tests\": \"f8f0e84911f31bbab6e6467c047e2ba68572ee26\", \"pdf_unittests\": \"b43a55226eb4ac282840caa750dfcb775b715f4d\", \"blink_platform_unittests\": \"c98581797f5eb4d81f5c86f9d7ef3c5db7276853\", \"components_browsertests\": \"f448c1900272b88103d0132079adffed7ef89585\", \"views_perftests\": \"867ca05ebab05c4045bd9b473f405235fbe5b53e\", \"angle_perftests\": \"e7923f58ec381b783d813664a70909237d792e03\", \"display_unittests\": \"a2c610b0e760d74787fe78da50414e0df11b9187\", \"sbox_unittests\": \"0961bc4c19c0fdbcadae5bfd39ec0854c229e97e\", \"service_manager_unittests\": \"5fc1acc90a699f642567bc51ce1ac32bd5d78c6c\", \"angle_end2end_tests\": \"24734c5a9de2600a1e5167d0ca1a27964475e544\", \"jingle_unittests\": \"06aa8e63b386643edebc15fe56cb7113b07754ac\", \"skia_unittests\": \"dd3b6609d92a608865be1fcfb804b7fe95efe133\", \"angle_white_box_tests\": \"8404a13eedffbffc2c009deb425cb15debb8c5c6\", \"crypto_unittests\": \"201c293d20dee0ae8c9c2e4909f0054758cb9ced\", \"nacl_loader_unittests\": \"2dc91240f4adae95bbd0d367a7dfe533f49dbd3a\", \"unit_tests\": \"6398f4508469fccf24a9628321bc076daa80bd0d\", \"content_browsertests\": \"5809791b236bc4536e711cda5a0a82aa03eb8210\", \"printing_unittests\": \"d1f067fb042748351ead6f8ef08c024e7c838f60\", \"device_unittests\": \"0221e94ebde322a874c2627bd5274ba2ffc28193\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1541782313325662",
"status": "COMPLETED",
"status_changed_ts": "1541791342515842",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10680",
"builder:Windows deterministic",
"buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095747967939453920",
"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/10680",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930317905735289280",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:07cf985bf9b48c12ac1d4a614dc409fd274dc3f1",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c8c6f7ecd6a1927225c2257544c6d370441854f",
"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/8930317905735289280/+/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:9095747967939453920",
"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:07cf985bf9b48c12ac1d4a614dc409fd274dc3f1",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:411232e45a08af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1541791342517862",
"url": "https://ci.chromium.org/b/8930317905735289280",
"utcnow_ts": "1541791343111955"
}
}
[19:22:23.179] Invocation finished in 2h32m26.50003618s with status SUCCEEDED