[12:45:50.992] New invocation is queued and will start shortly
[12:45:52.230] Starting the invocation (attempt 1)
[12:45:52.272] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:45:52.273] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:45:52.273] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069037220040676688",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"98b3a559e86d3333e235bd99aef103b2a2ef996d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9069037220040676688",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"gitiles_ref:refs/heads/master"
]
}
[12:45:53.815] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567255552461037",
"id": "8903607157780987984",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"98b3a559e86d3333e235bd99aef103b2a2ef996d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567255552896317",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14586",
"builder:Windows deterministic",
"buildset:commit/git/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069037220040676688",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903607157780987984/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1567255552896417",
"url": "https://ci.chromium.org/b/8903607157780987984",
"utcnow_ts": "1567255553735844"
}
}
[12:45:53.815] Task URL: https://ci.chromium.org/b/8903607157780987984
[12:45:53.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:2:0) after 1m0s
[12:45:55.335] Received PubSub notification, asking Buildbucket for the build status
[12:45:55.497] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:53.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:2:0)
[12:46:53.840] Timer tick, asking Buildbucket for the build status
[12:46:53.985] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:53.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:4:0) after 1m0s
[12:47:54.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:4:0)
[12:47:54.008] Timer tick, asking Buildbucket for the build status
[12:47:54.152] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:54.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:5:0) after 1m0s
[12:48:54.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:5:0)
[12:48:54.173] Timer tick, asking Buildbucket for the build status
[12:48:54.568] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:54.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:6:0) after 1m0s
[12:49:54.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:6:0)
[12:49:54.589] Timer tick, asking Buildbucket for the build status
[12:49:54.958] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:54.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:7:0) after 1m0s
[12:50:54.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:7:0)
[12:50:54.986] Timer tick, asking Buildbucket for the build status
[12:50:55.182] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:55.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:8:0) after 1m0s
[12:51:55.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:8:0)
[12:51:55.211] Timer tick, asking Buildbucket for the build status
[12:51:55.476] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:55.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:9:0) after 1m0s
[12:52:55.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:9:0)
[12:52:55.540] Timer tick, asking Buildbucket for the build status
[12:52:56.591] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:56.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:10:0) after 1m0s
[12:53:56.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:10:0)
[12:53:56.807] Timer tick, asking Buildbucket for the build status
[12:53:57.424] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:57.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:11:0) after 1m0s
[12:54:58.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:11:0)
[12:54:58.557] Timer tick, asking Buildbucket for the build status
[12:54:58.773] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:58.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:12:0) after 1m0s
[12:55:58.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:12:0)
[12:55:58.805] Timer tick, asking Buildbucket for the build status
[12:55:59.001] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:59.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:13:0) after 1m0s
[12:56:59.050] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:13:0)
[12:56:59.050] Timer tick, asking Buildbucket for the build status
[12:56:59.308] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:59.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:14:0) after 1m0s
[12:57:59.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:14:0)
[12:57:59.432] Timer tick, asking Buildbucket for the build status
[12:58:00.100] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:00.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:15:0) after 1m0s
[12:59:00.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:15:0)
[12:59:00.142] Timer tick, asking Buildbucket for the build status
[12:59:00.372] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:00.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:16:0) after 1m0s
[13:00:00.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:16:0)
[13:00:00.393] Timer tick, asking Buildbucket for the build status
[13:00:00.575] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:00.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:17:0) after 1m0s
[13:01:00.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:17:0)
[13:01:00.599] Timer tick, asking Buildbucket for the build status
[13:01:00.984] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:00.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:18:0) after 1m0s
[13:02:01.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:18:0)
[13:02:01.009] Timer tick, asking Buildbucket for the build status
[13:02:02.086] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:02.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:19:0) after 1m0s
[13:03:02.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:19:0)
[13:03:02.185] Timer tick, asking Buildbucket for the build status
[13:03:02.729] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:02.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:20:0) after 1m0s
[13:04:02.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:20:0)
[13:04:02.777] Timer tick, asking Buildbucket for the build status
[13:04:03.503] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:03.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:21:0) after 1m0s
[13:05:03.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:21:0)
[13:05:03.576] Timer tick, asking Buildbucket for the build status
[13:05:04.345] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:04.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:22:0) after 1m0s
[13:06:04.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:22:0)
[13:06:04.420] Timer tick, asking Buildbucket for the build status
[13:06:04.642] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:04.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:23:0) after 1m0s
[13:07:04.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:23:0)
[13:07:04.800] Timer tick, asking Buildbucket for the build status
[13:07:05.678] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:05.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:24:0) after 1m0s
[13:08:05.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:24:0)
[13:08:05.706] Timer tick, asking Buildbucket for the build status
[13:08:06.102] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:06.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:25:0) after 1m0s
[13:09:06.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:25:0)
[13:09:06.218] Timer tick, asking Buildbucket for the build status
[13:09:06.708] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:06.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:26:0) after 1m0s
[13:10:06.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:26:0)
[13:10:06.776] Timer tick, asking Buildbucket for the build status
[13:10:06.951] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:06.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:27:0) after 1m0s
[13:11:07.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:27:0)
[13:11:07.076] Timer tick, asking Buildbucket for the build status
[13:11:07.276] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:07.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:28:0) after 1m0s
[13:12:07.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:28:0)
[13:12:07.297] Timer tick, asking Buildbucket for the build status
[13:12:07.625] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:07.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:29:0) after 1m0s
[13:13:07.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:29:0)
[13:13:07.696] Timer tick, asking Buildbucket for the build status
[13:13:08.019] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:08.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:30:0) after 1m0s
[13:14:08.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:30:0)
[13:14:08.149] Timer tick, asking Buildbucket for the build status
[13:14:08.413] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:08.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:31:0) after 1m0s
[13:15:08.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:31:0)
[13:15:08.604] Timer tick, asking Buildbucket for the build status
[13:15:12.417] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:32:0) after 1m0s
[13:16:12.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:32:0)
[13:16:12.442] Timer tick, asking Buildbucket for the build status
[13:16:13.152] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:13.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:33:0) after 1m0s
[13:17:13.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:33:0)
[13:17:13.207] Timer tick, asking Buildbucket for the build status
[13:17:13.391] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:13.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:34:0) after 1m0s
[13:18:13.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:34:0)
[13:18:13.413] Timer tick, asking Buildbucket for the build status
[13:18:13.703] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:35:0) after 1m0s
[13:19:13.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:35:0)
[13:19:13.742] Timer tick, asking Buildbucket for the build status
[13:19:14.286] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:14.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:36:0) after 1m0s
[13:20:14.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:36:0)
[13:20:14.326] Timer tick, asking Buildbucket for the build status
[13:20:14.490] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:14.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:37:0) after 1m0s
[13:21:14.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:37:0)
[13:21:14.510] Timer tick, asking Buildbucket for the build status
[13:21:15.267] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:15.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:38:0) after 1m0s
[13:22:15.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:38:0)
[13:22:15.344] Timer tick, asking Buildbucket for the build status
[13:22:15.725] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:15.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:39:0) after 1m0s
[13:23:15.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:39:0)
[13:23:15.797] Timer tick, asking Buildbucket for the build status
[13:23:15.959] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:15.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:40:0) after 1m0s
[13:24:15.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:40:0)
[13:24:15.992] Timer tick, asking Buildbucket for the build status
[13:24:16.304] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:16.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:41:0) after 1m0s
[13:25:16.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:41:0)
[13:25:16.325] Timer tick, asking Buildbucket for the build status
[13:25:16.705] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:16.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:42:0) after 1m0s
[13:26:16.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:42:0)
[13:26:16.732] Timer tick, asking Buildbucket for the build status
[13:26:16.895] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:16.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:43:0) after 1m0s
[13:27:16.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:43:0)
[13:27:16.953] Timer tick, asking Buildbucket for the build status
[13:27:17.187] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:17.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:44:0) after 1m0s
[13:28:17.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:44:0)
[13:28:17.244] Timer tick, asking Buildbucket for the build status
[13:28:17.843] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:17.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:45:0) after 1m0s
[13:29:17.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:45:0)
[13:29:17.934] Timer tick, asking Buildbucket for the build status
[13:29:18.181] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:18.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:46:0) after 1m0s
[13:30:18.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:46:0)
[13:30:18.208] Timer tick, asking Buildbucket for the build status
[13:30:18.392] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:18.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:47:0) after 1m0s
[13:31:18.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:47:0)
[13:31:18.492] Timer tick, asking Buildbucket for the build status
[13:31:19.519] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:19.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:48:0) after 1m0s
[13:32:19.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:48:0)
[13:32:19.547] Timer tick, asking Buildbucket for the build status
[13:32:19.701] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:19.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:49:0) after 1m0s
[13:33:19.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:49:0)
[13:33:19.674] Timer tick, asking Buildbucket for the build status
[13:33:20.440] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:20.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:50:0) after 1m0s
[13:34:20.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:50:0)
[13:34:20.472] Timer tick, asking Buildbucket for the build status
[13:34:20.664] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:20.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:51:0) after 1m0s
[13:35:20.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:51:0)
[13:35:20.644] Timer tick, asking Buildbucket for the build status
[13:35:20.815] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:20.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:52:0) after 1m0s
[13:36:20.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:52:0)
[13:36:20.840] Timer tick, asking Buildbucket for the build status
[13:36:21.013] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:21.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:53:0) after 1m0s
[13:37:21.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:53:0)
[13:37:21.048] Timer tick, asking Buildbucket for the build status
[13:37:21.347] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:21.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:54:0) after 1m0s
[13:38:21.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:54:0)
[13:38:21.320] Timer tick, asking Buildbucket for the build status
[13:38:21.572] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:21.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:55:0) after 1m0s
[13:39:21.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:55:0)
[13:39:21.580] Timer tick, asking Buildbucket for the build status
[13:39:24.642] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:24.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:56:0) after 1m0s
[13:40:24.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:56:0)
[13:40:24.766] Timer tick, asking Buildbucket for the build status
[13:40:24.955] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:24.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:57:0) after 1m0s
[13:41:24.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:57:0)
[13:41:24.965] Timer tick, asking Buildbucket for the build status
[13:41:26.397] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:58:0) after 1m0s
[13:42:26.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:58:0)
[13:42:26.473] Timer tick, asking Buildbucket for the build status
[13:42:26.671] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:26.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:59:0) after 1m0s
[13:43:26.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:59:0)
[13:43:26.733] Timer tick, asking Buildbucket for the build status
[13:43:26.898] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:26.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:60:0) after 1m0s
[13:44:26.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:60:0)
[13:44:26.911] Timer tick, asking Buildbucket for the build status
[13:44:27.334] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:27.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:61:0) after 1m0s
[13:45:27.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:61:0)
[13:45:27.357] Timer tick, asking Buildbucket for the build status
[13:45:27.550] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:27.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:62:0) after 1m0s
[13:46:27.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:62:0)
[13:46:27.576] Timer tick, asking Buildbucket for the build status
[13:46:27.761] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:27.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:63:0) after 1m0s
[13:47:27.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:63:0)
[13:47:27.785] Timer tick, asking Buildbucket for the build status
[13:47:27.960] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:27.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:64:0) after 1m0s
[13:48:27.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:64:0)
[13:48:27.992] Timer tick, asking Buildbucket for the build status
[13:48:28.558] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:28.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:65:0) after 1m0s
[13:49:28.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:65:0)
[13:49:28.593] Timer tick, asking Buildbucket for the build status
[13:49:28.798] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:28.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:66:0) after 1m0s
[13:50:28.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:66:0)
[13:50:28.873] Timer tick, asking Buildbucket for the build status
[13:50:29.053] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:29.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:67:0) after 1m0s
[13:51:29.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:67:0)
[13:51:29.177] Timer tick, asking Buildbucket for the build status
[13:51:29.534] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:29.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:68:0) after 1m0s
[13:52:29.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:68:0)
[13:52:29.557] Timer tick, asking Buildbucket for the build status
[13:52:30.304] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:30.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:69:0) after 1m0s
[13:53:30.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:69:0)
[13:53:30.325] Timer tick, asking Buildbucket for the build status
[13:53:30.948] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:30.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:70:0) after 1m0s
[13:54:30.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:70:0)
[13:54:30.966] Timer tick, asking Buildbucket for the build status
[13:54:31.307] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:31.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:71:0) after 1m0s
[13:55:31.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:71:0)
[13:55:31.333] Timer tick, asking Buildbucket for the build status
[13:55:31.511] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:31.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:72:0) after 1m0s
[13:56:31.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:72:0)
[13:56:31.567] Timer tick, asking Buildbucket for the build status
[13:56:32.625] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:32.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:73:0) after 1m0s
[13:57:32.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:73:0)
[13:57:32.858] Timer tick, asking Buildbucket for the build status
[13:57:33.019] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:33.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:74:0) after 1m0s
[13:58:33.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:74:0)
[13:58:33.151] Timer tick, asking Buildbucket for the build status
[13:58:33.316] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:33.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:75:0) after 1m0s
[13:59:33.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:75:0)
[13:59:33.828] Timer tick, asking Buildbucket for the build status
[13:59:34.050] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:34.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:76:0) after 1m0s
[14:00:34.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:76:0)
[14:00:34.190] Timer tick, asking Buildbucket for the build status
[14:00:34.392] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:34.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:77:0) after 1m0s
[14:01:34.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:77:0)
[14:01:34.571] Timer tick, asking Buildbucket for the build status
[14:01:35.341] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:35.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:78:0) after 1m0s
[14:02:35.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:78:0)
[14:02:35.347] Timer tick, asking Buildbucket for the build status
[14:02:35.612] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:35.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:79:0) after 1m0s
[14:03:35.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:79:0)
[14:03:35.637] Timer tick, asking Buildbucket for the build status
[14:03:35.880] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:80:0) after 1m0s
[14:04:36.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:80:0)
[14:04:36.004] Timer tick, asking Buildbucket for the build status
[14:04:36.628] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:36.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:81:0) after 1m0s
[14:05:36.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:81:0)
[14:05:36.734] Timer tick, asking Buildbucket for the build status
[14:05:36.925] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:36.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:82:0) after 1m0s
[14:06:36.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:82:0)
[14:06:36.999] Timer tick, asking Buildbucket for the build status
[14:06:37.898] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:37.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:83:0) after 1m0s
[14:07:38.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:83:0)
[14:07:38.001] Timer tick, asking Buildbucket for the build status
[14:07:38.203] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:38.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:84:0) after 1m0s
[14:08:38.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:84:0)
[14:08:38.229] Timer tick, asking Buildbucket for the build status
[14:08:39.083] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:39.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:85:0) after 1m0s
[14:09:39.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:85:0)
[14:09:39.212] Timer tick, asking Buildbucket for the build status
[14:09:39.865] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:39.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:86:0) after 1m0s
[14:10:39.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:86:0)
[14:10:39.892] Timer tick, asking Buildbucket for the build status
[14:10:40.103] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:40.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:87:0) after 1m0s
[14:11:40.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:87:0)
[14:11:40.158] Timer tick, asking Buildbucket for the build status
[14:11:40.336] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:40.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:88:0) after 1m0s
[14:12:40.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:88:0)
[14:12:40.479] Timer tick, asking Buildbucket for the build status
[14:12:40.820] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:89:0) after 1m0s
[14:13:40.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:89:0)
[14:13:40.843] Timer tick, asking Buildbucket for the build status
[14:13:41.034] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:41.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:90:0) after 1m0s
[14:14:41.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:90:0)
[14:14:41.067] Timer tick, asking Buildbucket for the build status
[14:14:41.305] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:41.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:91:0) after 1m0s
[14:15:41.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:91:0)
[14:15:41.332] Timer tick, asking Buildbucket for the build status
[14:15:41.981] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:41.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:92:0) after 1m0s
[14:16:42.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:92:0)
[14:16:42.009] Timer tick, asking Buildbucket for the build status
[14:16:42.700] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:42.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:93:0) after 1m0s
[14:17:42.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:93:0)
[14:17:42.741] Timer tick, asking Buildbucket for the build status
[14:17:43.118] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:43.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:94:0) after 1m0s
[14:18:43.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:94:0)
[14:18:43.159] Timer tick, asking Buildbucket for the build status
[14:18:43.480] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:43.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:95:0) after 1m0s
[14:19:43.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:95:0)
[14:19:43.506] Timer tick, asking Buildbucket for the build status
[14:19:43.939] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:43.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:96:0) after 1m0s
[14:20:44.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:96:0)
[14:20:44.060] Timer tick, asking Buildbucket for the build status
[14:20:44.234] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:44.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:97:0) after 1m0s
[14:21:44.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:97:0)
[14:21:44.256] Timer tick, asking Buildbucket for the build status
[14:21:44.808] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:44.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:98:0) after 1m0s
[14:22:44.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:98:0)
[14:22:44.874] Timer tick, asking Buildbucket for the build status
[14:22:45.046] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:45.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:99:0) after 1m0s
[14:23:45.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:99:0)
[14:23:45.038] Timer tick, asking Buildbucket for the build status
[14:23:45.627] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:45.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:100:0) after 1m0s
[14:24:45.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:100:0)
[14:24:45.655] Timer tick, asking Buildbucket for the build status
[14:24:45.851] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:45.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:101:0) after 1m0s
[14:25:45.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:101:0)
[14:25:45.877] Timer tick, asking Buildbucket for the build status
[14:25:46.053] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:46.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:102:0) after 1m0s
[14:26:46.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:102:0)
[14:26:46.078] Timer tick, asking Buildbucket for the build status
[14:26:46.573] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:46.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:103:0) after 1m0s
[14:27:46.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:103:0)
[14:27:46.602] Timer tick, asking Buildbucket for the build status
[14:27:46.930] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:46.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:104:0) after 1m0s
[14:28:47.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:104:0)
[14:28:47.026] Timer tick, asking Buildbucket for the build status
[14:28:48.029] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:48.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:105:0) after 1m0s
[14:29:48.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:105:0)
[14:29:48.076] Timer tick, asking Buildbucket for the build status
[14:29:48.240] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:48.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:106:0) after 1m0s
[14:30:48.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:106:0)
[14:30:48.319] Timer tick, asking Buildbucket for the build status
[14:30:50.469] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:50.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:107:0) after 1m0s
[14:31:50.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:107:0)
[14:31:50.649] Timer tick, asking Buildbucket for the build status
[14:31:51.157] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:51.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:108:0) after 1m0s
[14:32:51.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:108:0)
[14:32:51.228] Timer tick, asking Buildbucket for the build status
[14:32:51.490] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:51.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:109:0) after 1m0s
[14:33:51.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:109:0)
[14:33:51.511] Timer tick, asking Buildbucket for the build status
[14:33:51.685] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:51.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:110:0) after 1m0s
[14:34:51.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:110:0)
[14:34:51.757] Timer tick, asking Buildbucket for the build status
[14:34:52.952] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:52.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:111:0) after 1m0s
[14:35:53.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:111:0)
[14:35:53.045] Timer tick, asking Buildbucket for the build status
[14:35:53.309] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:53.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:112:0) after 1m0s
[14:36:53.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:112:0)
[14:36:53.426] Timer tick, asking Buildbucket for the build status
[14:36:53.935] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:53.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:113:0) after 1m0s
[14:37:53.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:113:0)
[14:37:53.983] Timer tick, asking Buildbucket for the build status
[14:37:54.185] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:54.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:114:0) after 1m0s
[14:38:54.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:114:0)
[14:38:54.274] Timer tick, asking Buildbucket for the build status
[14:38:54.431] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:54.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:115:0) after 1m0s
[14:39:54.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:115:0)
[14:39:54.605] Timer tick, asking Buildbucket for the build status
[14:39:54.761] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:54.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:116:0) after 1m0s
[14:40:54.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:116:0)
[14:40:54.840] Timer tick, asking Buildbucket for the build status
[14:40:55.033] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:55.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:117:0) after 1m0s
[14:41:55.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:117:0)
[14:41:55.081] Timer tick, asking Buildbucket for the build status
[14:41:55.268] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:55.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:118:0) after 1m0s
[14:42:55.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:118:0)
[14:42:55.298] Timer tick, asking Buildbucket for the build status
[14:42:56.159] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:56.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:119:0) after 1m0s
[14:43:56.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:119:0)
[14:43:56.340] Timer tick, asking Buildbucket for the build status
[14:43:56.629] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:56.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:120:0) after 1m0s
[14:44:56.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:120:0)
[14:44:56.657] Timer tick, asking Buildbucket for the build status
[14:44:56.801] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:56.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:121:0) after 1m0s
[14:45:56.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:121:0)
[14:45:56.877] Timer tick, asking Buildbucket for the build status
[14:45:57.761] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:57.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:122:0) after 1m0s
[14:46:57.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:122:0)
[14:46:57.918] Timer tick, asking Buildbucket for the build status
[14:46:58.876] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:58.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:123:0) after 1m0s
[14:47:59.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:123:0)
[14:47:59.060] Timer tick, asking Buildbucket for the build status
[14:47:59.231] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:59.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:124:0) after 1m0s
[14:49:02.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:124:0)
[14:49:02.123] Timer tick, asking Buildbucket for the build status
[14:49:02.299] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:02.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:125:0) after 1m0s
[14:50:02.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:125:0)
[14:50:02.341] Timer tick, asking Buildbucket for the build status
[14:50:02.938] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:02.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:126:0) after 1m0s
[14:51:02.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:126:0)
[14:51:02.967] Timer tick, asking Buildbucket for the build status
[14:51:03.441] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:03.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:127:0) after 1m0s
[14:52:03.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:127:0)
[14:52:03.542] Timer tick, asking Buildbucket for the build status
[14:52:03.730] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:03.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:128:0) after 1m0s
[14:53:03.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:128:0)
[14:53:03.732] Timer tick, asking Buildbucket for the build status
[14:53:04.318] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:04.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:129:0) after 1m0s
[14:54:04.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:129:0)
[14:54:04.345] Timer tick, asking Buildbucket for the build status
[14:54:04.501] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:04.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:130:0) after 1m0s
[14:55:04.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:130:0)
[14:55:04.613] Timer tick, asking Buildbucket for the build status
[14:55:04.856] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:04.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:131:0) after 1m0s
[14:56:05.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:131:0)
[14:56:05.042] Timer tick, asking Buildbucket for the build status
[14:56:05.522] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:05.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:132:0) after 1m0s
[14:57:05.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:132:0)
[14:57:05.558] Timer tick, asking Buildbucket for the build status
[14:57:05.729] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:05.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:133:0) after 1m0s
[14:58:05.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:133:0)
[14:58:05.953] Timer tick, asking Buildbucket for the build status
[14:58:06.888] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:06.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:134:0) after 1m0s
[14:59:07.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:134:0)
[14:59:07.131] Timer tick, asking Buildbucket for the build status
[14:59:07.351] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:07.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:135:0) after 1m0s
[15:00:07.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:135:0)
[15:00:07.416] Timer tick, asking Buildbucket for the build status
[15:00:08.159] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:08.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:136:0) after 1m0s
[15:01:10.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:136:0)
[15:01:10.016] Timer tick, asking Buildbucket for the build status
[15:01:10.236] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:10.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:137:0) after 1m0s
[15:02:10.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:137:0)
[15:02:10.616] Timer tick, asking Buildbucket for the build status
[15:02:11.480] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:11.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:138:0) after 1m0s
[15:03:11.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:138:0)
[15:03:11.478] Timer tick, asking Buildbucket for the build status
[15:03:11.652] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:11.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:139:0) after 1m0s
[15:04:11.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:139:0)
[15:04:11.685] Timer tick, asking Buildbucket for the build status
[15:04:12.296] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:12.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:140:0) after 1m0s
[15:05:12.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:140:0)
[15:05:12.325] Timer tick, asking Buildbucket for the build status
[15:05:12.980] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:12.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:141:0) after 1m0s
[15:06:13.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:141:0)
[15:06:13.077] Timer tick, asking Buildbucket for the build status
[15:06:13.299] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:13.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:142:0) after 1m0s
[15:07:13.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:142:0)
[15:07:13.328] Timer tick, asking Buildbucket for the build status
[15:07:13.489] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:13.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:143:0) after 1m0s
[15:08:13.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:143:0)
[15:08:13.518] Timer tick, asking Buildbucket for the build status
[15:08:14.736] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:14.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:144:0) after 1m0s
[15:09:14.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:144:0)
[15:09:14.752] Timer tick, asking Buildbucket for the build status
[15:09:14.952] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:145:0) after 1m0s
[15:10:15.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:145:0)
[15:10:15.008] Timer tick, asking Buildbucket for the build status
[15:10:15.307] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:15.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:146:0) after 1m0s
[15:11:15.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:146:0)
[15:11:15.389] Timer tick, asking Buildbucket for the build status
[15:11:15.600] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:15.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:147:0) after 1m0s
[15:12:15.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:147:0)
[15:12:15.627] Timer tick, asking Buildbucket for the build status
[15:12:16.071] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:16.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:148:0) after 1m0s
[15:13:16.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:148:0)
[15:13:16.112] Timer tick, asking Buildbucket for the build status
[15:13:16.502] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:149:0) after 1m0s
[15:14:16.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:149:0)
[15:14:16.542] Timer tick, asking Buildbucket for the build status
[15:14:17.217] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:17.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:150:0) after 1m0s
[15:15:17.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:150:0)
[15:15:17.664] Timer tick, asking Buildbucket for the build status
[15:15:18.305] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:18.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:151:0) after 1m0s
[15:16:18.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:151:0)
[15:16:18.425] Timer tick, asking Buildbucket for the build status
[15:16:18.606] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:18.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:152:0) after 1m0s
[15:17:18.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:152:0)
[15:17:18.640] Timer tick, asking Buildbucket for the build status
[15:17:19.433] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:19.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:153:0) after 1m0s
[15:18:19.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:153:0)
[15:18:19.459] Timer tick, asking Buildbucket for the build status
[15:18:19.793] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:154:0) after 1m0s
[15:19:19.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:154:0)
[15:19:19.822] Timer tick, asking Buildbucket for the build status
[15:19:19.954] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:19.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:155:0) after 1m0s
[15:20:19.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:155:0)
[15:20:19.979] Timer tick, asking Buildbucket for the build status
[15:20:20.187] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:20.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:156:0) after 1m0s
[15:21:20.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:156:0)
[15:21:20.294] Timer tick, asking Buildbucket for the build status
[15:21:22.622] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:22.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:157:0) after 1m0s
[15:22:22.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:157:0)
[15:22:22.650] Timer tick, asking Buildbucket for the build status
[15:22:22.964] Build 8903607157780987984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:22.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069037220040676688:158:0) after 1m0s
[15:22:53.792] Received PubSub notification, asking Buildbucket for the build status
[15:22:54.439] Build 8903607157780987984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:22:54.439] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567264972714162",
"created_by": "project:chromium",
"created_ts": "1567255552461037",
"id": "8903607157780987984",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"98b3a559e86d3333e235bd99aef103b2a2ef996d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-bzrg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14586, \"got_angle_revision\": \"c3f57231124b74dd069550dabf5196f988fc8666\", \"got_dawn_revision\": \"824424fa351be2b2eccd78b2f31de1d5d1ad4183\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"98b3a559e86d3333e235bd99aef103b2a2ef996d\", \"got_revision_cp\": \"refs/heads/master@{#692354}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"aa3fccf48bfd34411bd3c232a5b952a5b859df82\", \"got_v8_revision_cp\": \"refs/heads/7.8.242@{#1}\", \"got_webrtc_revision\": \"ce6a0c8fb3f3a19caa797d5913b7e7c8ecf3ca9b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29029}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"98b3a559e86d3333e235bd99aef103b2a2ef996d\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-bzrg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567255554643581",
"status": "COMPLETED",
"status_changed_ts": "1567264973109367",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14586",
"builder:Windows deterministic",
"buildset:commit/git/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98b3a559e86d3333e235bd99aef103b2a2ef996d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069037220040676688",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903607157780987984/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4700876e5e530410",
"user_agent:luci-scheduler"
],
"updated_ts": "1567264973117539",
"url": "https://ci.chromium.org/b/8903607157780987984",
"utcnow_ts": "1567264974425421"
}
}
[15:22:54.439] Invocation finished in 2h37m3.517109056s with status SUCCEEDED