[10:58:45.206] New invocation is queued and will start shortly
[10:58:46.343] Starting the invocation (attempt 1)
[10:58:46.391] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:46.391] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:46.391] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040234122602491440",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a138fbb62191c57703b9e14281fb8a0f631fe691\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9040234122602491440",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/a138fbb62191c57703b9e14281fb8a0f631fe691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a138fbb62191c57703b9e14281fb8a0f631fe691",
"gitiles_ref:refs/heads/master"
]
}
[10:58:47.720] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594724326585421",
"id": "8874804060485095776",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a138fbb62191c57703b9e14281fb8a0f631fe691\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594724327492515",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16839",
"builder:Windows deterministic",
"buildset:commit/git/a138fbb62191c57703b9e14281fb8a0f631fe691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a138fbb62191c57703b9e14281fb8a0f631fe691",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040234122602491440",
"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/8874804060485095776/+/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": "1594724327492716",
"url": "https://ci.chromium.org/b/8874804060485095776",
"utcnow_ts": "1594724327709647"
}
}
[10:58:47.720] Task URL: https://ci.chromium.org/b/8874804060485095776
[10:58:47.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:2:0) after 1m0s
[10:59:47.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:2:0)
[10:59:47.939] Timer tick, asking Buildbucket for the build status
[10:59:48.165] Build 8874804060485095776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:48.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:3:0) after 1m0s
[11:00:41.560] Received PubSub notification, asking Buildbucket for the build status
[11:00:41.691] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:48.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:3:0)
[11:00:48.348] Timer tick, asking Buildbucket for the build status
[11:00:48.508] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:48.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:5:0) after 1m0s
[11:01:48.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:5:0)
[11:01:48.772] Timer tick, asking Buildbucket for the build status
[11:01:49.334] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:49.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:6:0) after 1m0s
[11:02:49.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:6:0)
[11:02:49.651] Timer tick, asking Buildbucket for the build status
[11:02:49.831] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:49.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:7:0) after 1m0s
[11:03:49.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:7:0)
[11:03:49.902] Timer tick, asking Buildbucket for the build status
[11:03:50.033] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:50.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:8:0) after 1m0s
[11:04:50.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:8:0)
[11:04:50.300] Timer tick, asking Buildbucket for the build status
[11:04:50.527] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:50.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:9:0) after 1m0s
[11:05:50.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:9:0)
[11:05:50.623] Timer tick, asking Buildbucket for the build status
[11:05:50.757] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:50.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:10:0) after 1m0s
[11:06:50.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:10:0)
[11:06:50.852] Timer tick, asking Buildbucket for the build status
[11:06:50.999] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:50.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:11:0) after 1m0s
[11:07:51.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:11:0)
[11:07:51.064] Timer tick, asking Buildbucket for the build status
[11:07:51.323] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:12:0) after 1m0s
[11:08:51.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:12:0)
[11:08:51.368] Timer tick, asking Buildbucket for the build status
[11:08:51.875] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:13:0) after 1m0s
[11:09:51.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:13:0)
[11:09:51.958] Timer tick, asking Buildbucket for the build status
[11:09:52.094] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:14:0) after 1m0s
[11:10:52.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:14:0)
[11:10:52.157] Timer tick, asking Buildbucket for the build status
[11:10:52.239] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:52.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:15:0) after 1m0s
[11:11:52.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:15:0)
[11:11:52.264] Timer tick, asking Buildbucket for the build status
[11:11:52.384] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:52.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:16:0) after 1m0s
[11:12:52.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:16:0)
[11:12:52.510] Timer tick, asking Buildbucket for the build status
[11:12:52.706] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:52.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:17:0) after 1m0s
[11:13:52.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:17:0)
[11:13:52.871] Timer tick, asking Buildbucket for the build status
[11:13:53.070] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:53.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:18:0) after 1m0s
[11:14:53.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:18:0)
[11:14:53.135] Timer tick, asking Buildbucket for the build status
[11:14:53.501] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:53.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:19:0) after 1m0s
[11:15:53.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:19:0)
[11:15:53.642] Timer tick, asking Buildbucket for the build status
[11:15:53.748] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:53.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:20:0) after 1m0s
[11:16:53.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:20:0)
[11:16:53.817] Timer tick, asking Buildbucket for the build status
[11:16:53.991] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:53.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:21:0) after 1m0s
[11:17:54.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:21:0)
[11:17:54.028] Timer tick, asking Buildbucket for the build status
[11:17:54.221] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:54.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:22:0) after 1m0s
[11:18:54.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:22:0)
[11:18:54.264] Timer tick, asking Buildbucket for the build status
[11:18:54.386] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:54.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:23:0) after 1m0s
[11:19:54.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:23:0)
[11:19:54.433] Timer tick, asking Buildbucket for the build status
[11:19:54.583] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:54.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:24:0) after 1m0s
[11:20:54.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:24:0)
[11:20:54.647] Timer tick, asking Buildbucket for the build status
[11:20:54.771] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:54.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:25:0) after 1m0s
[11:21:54.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:25:0)
[11:21:54.848] Timer tick, asking Buildbucket for the build status
[11:21:54.992] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:54.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:26:0) after 1m0s
[11:22:55.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:26:0)
[11:22:55.103] Timer tick, asking Buildbucket for the build status
[11:22:55.321] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:55.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:27:0) after 1m0s
[11:23:55.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:27:0)
[11:23:55.351] Timer tick, asking Buildbucket for the build status
[11:23:55.527] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:28:0) after 1m0s
[11:24:55.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:28:0)
[11:24:55.569] Timer tick, asking Buildbucket for the build status
[11:24:55.723] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:55.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:29:0) after 1m0s
[11:25:55.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:29:0)
[11:25:55.875] Timer tick, asking Buildbucket for the build status
[11:25:56.254] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:56.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:30:0) after 1m0s
[11:26:56.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:30:0)
[11:26:56.297] Timer tick, asking Buildbucket for the build status
[11:26:56.577] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:31:0) after 1m0s
[11:27:56.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:31:0)
[11:27:56.609] Timer tick, asking Buildbucket for the build status
[11:27:56.727] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:56.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:32:0) after 1m0s
[11:28:56.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:32:0)
[11:28:56.762] Timer tick, asking Buildbucket for the build status
[11:28:56.914] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:33:0) after 1m0s
[11:29:56.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:33:0)
[11:29:56.970] Timer tick, asking Buildbucket for the build status
[11:29:57.136] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:57.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:34:0) after 1m0s
[11:30:57.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:34:0)
[11:30:57.178] Timer tick, asking Buildbucket for the build status
[11:30:57.358] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:57.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:35:0) after 1m0s
[11:31:58.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:35:0)
[11:31:58.290] Timer tick, asking Buildbucket for the build status
[11:31:58.705] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:58.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:36:0) after 1m0s
[11:32:58.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:36:0)
[11:32:58.934] Timer tick, asking Buildbucket for the build status
[11:33:00.226] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:00.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:37:0) after 1m0s
[11:34:00.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:37:0)
[11:34:00.731] Timer tick, asking Buildbucket for the build status
[11:34:00.999] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:00.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:38:0) after 1m0s
[11:35:01.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:38:0)
[11:35:01.068] Timer tick, asking Buildbucket for the build status
[11:35:01.236] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:01.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:39:0) after 1m0s
[11:36:02.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:39:0)
[11:36:02.186] Timer tick, asking Buildbucket for the build status
[11:36:02.366] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:02.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:40:0) after 1m0s
[11:37:02.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:40:0)
[11:37:02.923] Timer tick, asking Buildbucket for the build status
[11:37:03.132] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:03.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:41:0) after 1m0s
[11:38:03.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:41:0)
[11:38:03.909] Timer tick, asking Buildbucket for the build status
[11:38:04.277] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:04.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:42:0) after 1m0s
[11:39:04.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:42:0)
[11:39:04.447] Timer tick, asking Buildbucket for the build status
[11:39:04.726] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:04.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:43:0) after 1m0s
[11:40:04.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:43:0)
[11:40:04.762] Timer tick, asking Buildbucket for the build status
[11:40:05.117] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:44:0) after 1m0s
[11:41:05.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:44:0)
[11:41:05.145] Timer tick, asking Buildbucket for the build status
[11:41:05.320] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:05.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:45:0) after 1m0s
[11:42:05.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:45:0)
[11:42:05.395] Timer tick, asking Buildbucket for the build status
[11:42:05.551] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:05.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:46:0) after 1m0s
[11:43:05.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:46:0)
[11:43:05.589] Timer tick, asking Buildbucket for the build status
[11:43:05.789] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:47:0) after 1m0s
[11:44:05.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:47:0)
[11:44:05.893] Timer tick, asking Buildbucket for the build status
[11:44:06.325] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:06.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:48:0) after 1m0s
[11:45:06.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:48:0)
[11:45:06.326] Timer tick, asking Buildbucket for the build status
[11:45:06.716] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:06.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:49:0) after 1m0s
[11:46:06.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:49:0)
[11:46:06.739] Timer tick, asking Buildbucket for the build status
[11:46:06.889] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:06.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:50:0) after 1m0s
[11:47:06.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:50:0)
[11:47:06.976] Timer tick, asking Buildbucket for the build status
[11:47:07.370] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:07.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:51:0) after 1m0s
[11:48:07.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:51:0)
[11:48:07.407] Timer tick, asking Buildbucket for the build status
[11:48:07.699] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:07.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:52:0) after 1m0s
[11:49:07.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:52:0)
[11:49:07.839] Timer tick, asking Buildbucket for the build status
[11:49:08.162] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:08.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:53:0) after 1m0s
[11:50:08.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:53:0)
[11:50:08.239] Timer tick, asking Buildbucket for the build status
[11:50:08.381] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:08.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:54:0) after 1m0s
[11:51:08.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:54:0)
[11:51:08.570] Timer tick, asking Buildbucket for the build status
[11:51:08.919] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:08.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:55:0) after 1m0s
[11:52:08.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:55:0)
[11:52:08.999] Timer tick, asking Buildbucket for the build status
[11:52:09.514] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:09.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:56:0) after 1m0s
[11:53:09.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:56:0)
[11:53:09.574] Timer tick, asking Buildbucket for the build status
[11:53:09.742] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:57:0) after 1m0s
[11:54:09.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:57:0)
[11:54:09.939] Timer tick, asking Buildbucket for the build status
[11:54:10.093] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:10.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:58:0) after 1m0s
[11:55:10.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:58:0)
[11:55:10.252] Timer tick, asking Buildbucket for the build status
[11:55:10.359] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:10.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:59:0) after 1m0s
[11:56:10.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:59:0)
[11:56:10.464] Timer tick, asking Buildbucket for the build status
[11:56:10.685] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:10.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:60:0) after 1m0s
[11:57:10.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:60:0)
[11:57:10.813] Timer tick, asking Buildbucket for the build status
[11:57:10.918] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:10.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:61:0) after 1m0s
[11:58:11.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:61:0)
[11:58:11.118] Timer tick, asking Buildbucket for the build status
[11:58:11.255] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:11.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:62:0) after 1m0s
[11:59:11.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:62:0)
[11:59:11.580] Timer tick, asking Buildbucket for the build status
[11:59:11.721] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:11.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:63:0) after 1m0s
[12:00:11.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:63:0)
[12:00:11.876] Timer tick, asking Buildbucket for the build status
[12:00:12.009] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:12.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:64:0) after 1m0s
[12:01:13.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:64:0)
[12:01:13.529] Timer tick, asking Buildbucket for the build status
[12:01:13.926] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:13.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:65:0) after 1m0s
[12:02:14.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:65:0)
[12:02:14.240] Timer tick, asking Buildbucket for the build status
[12:02:14.611] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:14.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:66:0) after 1m0s
[12:03:14.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:66:0)
[12:03:14.833] Timer tick, asking Buildbucket for the build status
[12:03:14.992] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:14.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:67:0) after 1m0s
[12:04:15.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:67:0)
[12:04:15.302] Timer tick, asking Buildbucket for the build status
[12:04:15.680] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:15.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:68:0) after 1m0s
[12:05:15.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:68:0)
[12:05:15.879] Timer tick, asking Buildbucket for the build status
[12:05:16.081] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:16.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:69:0) after 1m0s
[12:06:16.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:69:0)
[12:06:16.174] Timer tick, asking Buildbucket for the build status
[12:06:16.352] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:16.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:70:0) after 1m0s
[12:07:16.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:70:0)
[12:07:16.391] Timer tick, asking Buildbucket for the build status
[12:07:16.579] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:16.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:71:0) after 1m0s
[12:08:16.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:71:0)
[12:08:16.656] Timer tick, asking Buildbucket for the build status
[12:08:16.988] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:16.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:72:0) after 1m0s
[12:09:17.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:72:0)
[12:09:17.018] Timer tick, asking Buildbucket for the build status
[12:09:17.322] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:17.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:73:0) after 1m0s
[12:10:17.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:73:0)
[12:10:17.430] Timer tick, asking Buildbucket for the build status
[12:10:17.644] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:17.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:74:0) after 1m0s
[12:11:17.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:74:0)
[12:11:17.681] Timer tick, asking Buildbucket for the build status
[12:11:17.880] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:17.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:75:0) after 1m0s
[12:12:18.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:75:0)
[12:12:18.005] Timer tick, asking Buildbucket for the build status
[12:12:18.147] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:76:0) after 1m0s
[12:13:18.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:76:0)
[12:13:18.196] Timer tick, asking Buildbucket for the build status
[12:13:18.324] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:18.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:77:0) after 1m0s
[12:14:18.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:77:0)
[12:14:18.371] Timer tick, asking Buildbucket for the build status
[12:14:18.527] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:18.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:78:0) after 1m0s
[12:15:18.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:78:0)
[12:15:18.561] Timer tick, asking Buildbucket for the build status
[12:15:18.832] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:18.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:79:0) after 1m0s
[12:16:18.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:79:0)
[12:16:18.873] Timer tick, asking Buildbucket for the build status
[12:16:19.182] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:19.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:80:0) after 1m0s
[12:17:19.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:80:0)
[12:17:19.250] Timer tick, asking Buildbucket for the build status
[12:17:19.346] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:19.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:81:0) after 1m0s
[12:18:19.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:81:0)
[12:18:19.405] Timer tick, asking Buildbucket for the build status
[12:18:19.674] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:19.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:82:0) after 1m0s
[12:19:19.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:82:0)
[12:19:19.899] Timer tick, asking Buildbucket for the build status
[12:19:20.065] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:20.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:83:0) after 1m0s
[12:20:20.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:83:0)
[12:20:20.178] Timer tick, asking Buildbucket for the build status
[12:20:20.302] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:84:0) after 1m0s
[12:21:20.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:84:0)
[12:21:20.377] Timer tick, asking Buildbucket for the build status
[12:21:20.476] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:20.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:85:0) after 1m0s
[12:22:20.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:85:0)
[12:22:20.505] Timer tick, asking Buildbucket for the build status
[12:22:20.623] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:20.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:86:0) after 1m0s
[12:23:20.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:86:0)
[12:23:20.813] Timer tick, asking Buildbucket for the build status
[12:23:20.923] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:20.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:87:0) after 1m0s
[12:24:21.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:87:0)
[12:24:21.058] Timer tick, asking Buildbucket for the build status
[12:24:21.983] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:88:0) after 1m0s
[12:25:22.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:88:0)
[12:25:22.113] Timer tick, asking Buildbucket for the build status
[12:25:22.225] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:22.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:89:0) after 1m0s
[12:26:22.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:89:0)
[12:26:22.313] Timer tick, asking Buildbucket for the build status
[12:26:22.456] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:22.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:90:0) after 1m0s
[12:27:22.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:90:0)
[12:27:22.622] Timer tick, asking Buildbucket for the build status
[12:27:22.822] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:22.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:91:0) after 1m0s
[12:28:22.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:91:0)
[12:28:22.906] Timer tick, asking Buildbucket for the build status
[12:28:23.392] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:23.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:92:0) after 1m0s
[12:29:23.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:92:0)
[12:29:23.449] Timer tick, asking Buildbucket for the build status
[12:29:23.595] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:23.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:93:0) after 1m0s
[12:30:23.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:93:0)
[12:30:23.665] Timer tick, asking Buildbucket for the build status
[12:30:23.853] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:23.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:94:0) after 1m0s
[12:31:24.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:94:0)
[12:31:24.022] Timer tick, asking Buildbucket for the build status
[12:31:24.397] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:24.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:95:0) after 1m0s
[12:32:24.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:95:0)
[12:32:24.447] Timer tick, asking Buildbucket for the build status
[12:32:24.605] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:24.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:96:0) after 1m0s
[12:33:24.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:96:0)
[12:33:24.704] Timer tick, asking Buildbucket for the build status
[12:33:25.054] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:25.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:97:0) after 1m0s
[12:34:25.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:97:0)
[12:34:25.117] Timer tick, asking Buildbucket for the build status
[12:34:25.212] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:25.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:98:0) after 1m0s
[12:35:25.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:98:0)
[12:35:25.246] Timer tick, asking Buildbucket for the build status
[12:35:25.766] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:25.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:99:0) after 1m0s
[12:36:25.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:99:0)
[12:36:25.796] Timer tick, asking Buildbucket for the build status
[12:36:25.894] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:25.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:100:0) after 1m0s
[12:37:26.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:100:0)
[12:37:26.047] Timer tick, asking Buildbucket for the build status
[12:37:26.519] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:26.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:101:0) after 1m0s
[12:38:26.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:101:0)
[12:38:26.566] Timer tick, asking Buildbucket for the build status
[12:38:26.691] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:26.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:102:0) after 1m0s
[12:39:26.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:102:0)
[12:39:26.845] Timer tick, asking Buildbucket for the build status
[12:39:27.597] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:27.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:103:0) after 1m0s
[12:40:27.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:103:0)
[12:40:27.732] Timer tick, asking Buildbucket for the build status
[12:40:27.909] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:27.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:104:0) after 1m0s
[12:41:28.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:104:0)
[12:41:28.070] Timer tick, asking Buildbucket for the build status
[12:41:28.197] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:28.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:105:0) after 1m0s
[12:42:28.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:105:0)
[12:42:28.368] Timer tick, asking Buildbucket for the build status
[12:42:28.528] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:28.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:106:0) after 1m0s
[12:43:29.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:106:0)
[12:43:29.648] Timer tick, asking Buildbucket for the build status
[12:43:30.116] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:30.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:107:0) after 1m0s
[12:44:30.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:107:0)
[12:44:30.175] Timer tick, asking Buildbucket for the build status
[12:44:30.296] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:30.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:108:0) after 1m0s
[12:45:30.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:108:0)
[12:45:30.413] Timer tick, asking Buildbucket for the build status
[12:45:30.998] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:30.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:109:0) after 1m0s
[12:46:31.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:109:0)
[12:46:31.092] Timer tick, asking Buildbucket for the build status
[12:46:31.260] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:31.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:110:0) after 1m0s
[12:47:31.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:110:0)
[12:47:31.287] Timer tick, asking Buildbucket for the build status
[12:47:31.580] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:31.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:111:0) after 1m0s
[12:48:31.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:111:0)
[12:48:31.628] Timer tick, asking Buildbucket for the build status
[12:48:31.762] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:31.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:112:0) after 1m0s
[12:49:31.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:112:0)
[12:49:31.860] Timer tick, asking Buildbucket for the build status
[12:49:32.001] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:32.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:113:0) after 1m0s
[12:50:32.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:113:0)
[12:50:32.215] Timer tick, asking Buildbucket for the build status
[12:50:32.394] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:32.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:114:0) after 1m0s
[12:51:32.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:114:0)
[12:51:32.421] Timer tick, asking Buildbucket for the build status
[12:51:32.735] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:115:0) after 1m0s
[12:52:32.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:115:0)
[12:52:32.789] Timer tick, asking Buildbucket for the build status
[12:52:33.069] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:33.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:116:0) after 1m0s
[12:53:33.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:116:0)
[12:53:33.049] Timer tick, asking Buildbucket for the build status
[12:53:33.225] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:33.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:117:0) after 1m0s
[12:54:33.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:117:0)
[12:54:33.213] Timer tick, asking Buildbucket for the build status
[12:54:33.505] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:33.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:118:0) after 1m0s
[12:55:33.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:118:0)
[12:55:33.512] Timer tick, asking Buildbucket for the build status
[12:55:33.707] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:33.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:119:0) after 1m0s
[12:56:33.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:119:0)
[12:56:33.730] Timer tick, asking Buildbucket for the build status
[12:56:33.996] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:33.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:120:0) after 1m0s
[12:57:34.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:120:0)
[12:57:34.115] Timer tick, asking Buildbucket for the build status
[12:57:34.269] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:34.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:121:0) after 1m0s
[12:58:34.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:121:0)
[12:58:34.442] Timer tick, asking Buildbucket for the build status
[12:58:34.787] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:34.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:122:0) after 1m0s
[12:59:34.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:122:0)
[12:59:34.868] Timer tick, asking Buildbucket for the build status
[12:59:35.177] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:35.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:123:0) after 1m0s
[13:00:35.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:123:0)
[13:00:35.246] Timer tick, asking Buildbucket for the build status
[13:00:48.838] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:48.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:124:0) after 1m0s
[13:01:49.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:124:0)
[13:01:49.029] Timer tick, asking Buildbucket for the build status
[13:01:49.316] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:49.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:125:0) after 1m0s
[13:02:49.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:125:0)
[13:02:49.425] Timer tick, asking Buildbucket for the build status
[13:02:49.594] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:49.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:126:0) after 1m0s
[13:03:49.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:126:0)
[13:03:49.891] Timer tick, asking Buildbucket for the build status
[13:03:50.085] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:50.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:127:0) after 1m0s
[13:04:50.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:127:0)
[13:04:50.364] Timer tick, asking Buildbucket for the build status
[13:04:50.562] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:50.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:128:0) after 1m0s
[13:05:50.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:128:0)
[13:05:50.723] Timer tick, asking Buildbucket for the build status
[13:05:50.872] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:50.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:129:0) after 1m0s
[13:06:50.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:129:0)
[13:06:50.992] Timer tick, asking Buildbucket for the build status
[13:06:51.168] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:51.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:130:0) after 1m0s
[13:07:51.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:130:0)
[13:07:51.260] Timer tick, asking Buildbucket for the build status
[13:07:51.593] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:51.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:131:0) after 1m0s
[13:08:51.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:131:0)
[13:08:51.625] Timer tick, asking Buildbucket for the build status
[13:08:51.735] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:51.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:132:0) after 1m0s
[13:09:51.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:132:0)
[13:09:51.781] Timer tick, asking Buildbucket for the build status
[13:09:51.873] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:51.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:133:0) after 1m0s
[13:10:51.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:133:0)
[13:10:51.931] Timer tick, asking Buildbucket for the build status
[13:10:52.095] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:52.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:134:0) after 1m0s
[13:11:52.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:134:0)
[13:11:52.140] Timer tick, asking Buildbucket for the build status
[13:11:52.466] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:52.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:135:0) after 1m0s
[13:12:52.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:135:0)
[13:12:52.492] Timer tick, asking Buildbucket for the build status
[13:12:53.632] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:53.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:136:0) after 1m0s
[13:13:53.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:136:0)
[13:13:53.652] Timer tick, asking Buildbucket for the build status
[13:13:53.914] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:53.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:137:0) after 1m0s
[13:14:53.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:137:0)
[13:14:53.980] Timer tick, asking Buildbucket for the build status
[13:14:54.132] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:54.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:138:0) after 1m0s
[13:15:54.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:138:0)
[13:15:54.235] Timer tick, asking Buildbucket for the build status
[13:15:54.371] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:54.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:139:0) after 1m0s
[13:16:54.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:139:0)
[13:16:54.471] Timer tick, asking Buildbucket for the build status
[13:16:54.638] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:54.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:140:0) after 1m0s
[13:17:54.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:140:0)
[13:17:54.733] Timer tick, asking Buildbucket for the build status
[13:17:54.929] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:54.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:141:0) after 1m0s
[13:18:55.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:141:0)
[13:18:55.001] Timer tick, asking Buildbucket for the build status
[13:19:03.720] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:03.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:142:0) after 1m0s
[13:20:03.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:142:0)
[13:20:03.708] Timer tick, asking Buildbucket for the build status
[13:20:03.838] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:03.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:143:0) after 1m0s
[13:21:04.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:143:0)
[13:21:04.014] Timer tick, asking Buildbucket for the build status
[13:21:04.384] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:04.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:144:0) after 1m0s
[13:22:04.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:144:0)
[13:22:04.524] Timer tick, asking Buildbucket for the build status
[13:22:04.991] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:04.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:145:0) after 1m0s
[13:23:05.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:145:0)
[13:23:05.295] Timer tick, asking Buildbucket for the build status
[13:23:05.680] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:05.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:146:0) after 1m0s
[13:24:06.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:146:0)
[13:24:06.666] Timer tick, asking Buildbucket for the build status
[13:24:07.359] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:07.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:147:0) after 1m0s
[13:25:07.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:147:0)
[13:25:07.558] Timer tick, asking Buildbucket for the build status
[13:25:07.994] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:07.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:148:0) after 1m0s
[13:26:08.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:148:0)
[13:26:08.198] Timer tick, asking Buildbucket for the build status
[13:26:08.598] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:08.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:149:0) after 1m0s
[13:27:08.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:149:0)
[13:27:08.718] Timer tick, asking Buildbucket for the build status
[13:27:08.906] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:08.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:150:0) after 1m0s
[13:28:09.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:150:0)
[13:28:09.076] Timer tick, asking Buildbucket for the build status
[13:28:09.283] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:09.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:151:0) after 1m0s
[13:29:09.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:151:0)
[13:29:09.343] Timer tick, asking Buildbucket for the build status
[13:29:09.810] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:09.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:152:0) after 1m0s
[13:30:09.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:152:0)
[13:30:09.912] Timer tick, asking Buildbucket for the build status
[13:30:10.338] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:10.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:153:0) after 1m0s
[13:31:10.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:153:0)
[13:31:10.411] Timer tick, asking Buildbucket for the build status
[13:31:11.694] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:11.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:154:0) after 1m0s
[13:32:11.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:154:0)
[13:32:11.741] Timer tick, asking Buildbucket for the build status
[13:32:11.860] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:11.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:155:0) after 1m0s
[13:33:11.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:155:0)
[13:33:11.885] Timer tick, asking Buildbucket for the build status
[13:33:12.198] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:12.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:156:0) after 1m0s
[13:34:12.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:156:0)
[13:34:12.238] Timer tick, asking Buildbucket for the build status
[13:34:12.408] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:12.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:157:0) after 1m0s
[13:35:12.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:157:0)
[13:35:12.444] Timer tick, asking Buildbucket for the build status
[13:35:12.571] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:12.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:158:0) after 1m0s
[13:36:12.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:158:0)
[13:36:12.628] Timer tick, asking Buildbucket for the build status
[13:36:12.906] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:12.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:159:0) after 1m0s
[13:37:12.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:159:0)
[13:37:12.954] Timer tick, asking Buildbucket for the build status
[13:37:13.305] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:13.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:160:0) after 1m0s
[13:38:13.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:160:0)
[13:38:13.338] Timer tick, asking Buildbucket for the build status
[13:38:13.664] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:13.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:161:0) after 1m0s
[13:39:13.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:161:0)
[13:39:13.724] Timer tick, asking Buildbucket for the build status
[13:39:14.022] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:14.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:162:0) after 1m0s
[13:40:14.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:162:0)
[13:40:14.094] Timer tick, asking Buildbucket for the build status
[13:40:14.289] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:14.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:163:0) after 1m0s
[13:41:14.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:163:0)
[13:41:14.361] Timer tick, asking Buildbucket for the build status
[13:41:14.522] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:14.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:164:0) after 1m0s
[13:42:14.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:164:0)
[13:42:14.584] Timer tick, asking Buildbucket for the build status
[13:42:14.705] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:14.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:165:0) after 1m0s
[13:43:14.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:165:0)
[13:43:14.746] Timer tick, asking Buildbucket for the build status
[13:43:14.856] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:14.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:166:0) after 1m0s
[13:44:14.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:166:0)
[13:44:14.900] Timer tick, asking Buildbucket for the build status
[13:44:15.009] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:15.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:167:0) after 1m0s
[13:45:15.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:167:0)
[13:45:15.037] Timer tick, asking Buildbucket for the build status
[13:45:15.194] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:15.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:168:0) after 1m0s
[13:46:15.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:168:0)
[13:46:15.284] Timer tick, asking Buildbucket for the build status
[13:46:15.609] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:15.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:169:0) after 1m0s
[13:47:15.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:169:0)
[13:47:15.659] Timer tick, asking Buildbucket for the build status
[13:47:15.831] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:15.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:170:0) after 1m0s
[13:48:15.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:170:0)
[13:48:15.866] Timer tick, asking Buildbucket for the build status
[13:48:15.966] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:15.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:171:0) after 1m0s
[13:49:16.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:171:0)
[13:49:16.067] Timer tick, asking Buildbucket for the build status
[13:49:16.222] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:16.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:172:0) after 1m0s
[13:50:16.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:172:0)
[13:50:16.300] Timer tick, asking Buildbucket for the build status
[13:50:16.396] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:16.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:173:0) after 1m0s
[13:51:16.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:173:0)
[13:51:16.467] Timer tick, asking Buildbucket for the build status
[13:51:16.615] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:16.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:174:0) after 1m0s
[13:52:16.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:174:0)
[13:52:16.658] Timer tick, asking Buildbucket for the build status
[13:52:16.768] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:175:0) after 1m0s
[13:53:16.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:175:0)
[13:53:16.820] Timer tick, asking Buildbucket for the build status
[13:53:16.939] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:16.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:176:0) after 1m0s
[13:54:16.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:176:0)
[13:54:16.991] Timer tick, asking Buildbucket for the build status
[13:54:17.324] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:17.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:177:0) after 1m0s
[13:55:17.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:177:0)
[13:55:17.393] Timer tick, asking Buildbucket for the build status
[13:55:17.546] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:17.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:178:0) after 1m0s
[13:56:17.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:178:0)
[13:56:17.581] Timer tick, asking Buildbucket for the build status
[13:56:17.743] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:17.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:179:0) after 1m0s
[13:57:17.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:179:0)
[13:57:17.813] Timer tick, asking Buildbucket for the build status
[13:57:18.045] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:180:0) after 1m0s
[13:58:18.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:180:0)
[13:58:18.130] Timer tick, asking Buildbucket for the build status
[13:58:18.305] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:18.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:181:0) after 1m0s
[13:59:18.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:181:0)
[13:59:18.405] Timer tick, asking Buildbucket for the build status
[13:59:18.788] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:182:0) after 1m0s
[14:00:18.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:182:0)
[14:00:18.882] Timer tick, asking Buildbucket for the build status
[14:00:19.069] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:19.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:183:0) after 1m0s
[14:01:19.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:183:0)
[14:01:19.115] Timer tick, asking Buildbucket for the build status
[14:01:19.443] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:19.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:184:0) after 1m0s
[14:02:19.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:184:0)
[14:02:19.541] Timer tick, asking Buildbucket for the build status
[14:02:19.707] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:19.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:185:0) after 1m0s
[14:03:20.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:185:0)
[14:03:20.000] Timer tick, asking Buildbucket for the build status
[14:03:20.127] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:186:0) after 1m0s
[14:04:20.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:186:0)
[14:04:20.529] Timer tick, asking Buildbucket for the build status
[14:04:20.711] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:20.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:187:0) after 1m0s
[14:05:21.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:187:0)
[14:05:21.060] Timer tick, asking Buildbucket for the build status
[14:05:21.366] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:21.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:188:0) after 1m0s
[14:06:21.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:188:0)
[14:06:21.450] Timer tick, asking Buildbucket for the build status
[14:06:21.583] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:21.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:189:0) after 1m0s
[14:07:21.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:189:0)
[14:07:21.628] Timer tick, asking Buildbucket for the build status
[14:07:21.754] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:190:0) after 1m0s
[14:08:21.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:190:0)
[14:08:21.870] Timer tick, asking Buildbucket for the build status
[14:08:22.031] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:22.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:191:0) after 1m0s
[14:09:22.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:191:0)
[14:09:22.105] Timer tick, asking Buildbucket for the build status
[14:09:22.292] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:22.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:192:0) after 1m0s
[14:10:22.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:192:0)
[14:10:22.351] Timer tick, asking Buildbucket for the build status
[14:10:22.673] Build 8874804060485095776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:22.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9040234122602491440:193:0) after 1m0s
[14:11:01.569] Received PubSub notification, asking Buildbucket for the build status
[14:11:02.876] Build 8874804060485095776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:11:02.876] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594735860721912",
"created_by": "project:chromium",
"created_ts": "1594724326585421",
"id": "8874804060485095776",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a138fbb62191c57703b9e14281fb8a0f631fe691\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-br0b\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16839, \"got_angle_revision\": \"d98afb787a24285eccd554daa6b8de197187a636\", \"got_dawn_revision\": \"e700a6a76407255a7c65e933402b4516da547db5\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"a138fbb62191c57703b9e14281fb8a0f631fe691\", \"got_revision_cp\": \"refs/heads/master@{#788084}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"cd0af6456eb1c427943c2cf60d4f6234f821aa09\", \"got_v8_revision\": \"f97024e466afb803cd3cab4408cdaff0fee47fe1\", \"got_v8_revision_cp\": \"refs/heads/8.6.124@{#1}\", \"got_webrtc_revision\": \"8df59bc74ebb4d0b8e5d80a8b4f5c674db2a9c4d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31703}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a138fbb62191c57703b9e14281fb8a0f631fe691\"}, \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-br0b\"], \"image\": [\"chrome-win10-1703-20070700-8a9e7990cc1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5378-e275056\"], \"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": "1594724440540247",
"status": "COMPLETED",
"status_changed_ts": "1594735861185412",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16839",
"builder:Windows deterministic",
"buildset:commit/git/a138fbb62191c57703b9e14281fb8a0f631fe691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a138fbb62191c57703b9e14281fb8a0f631fe691",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040234122602491440",
"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/8874804060485095776/+/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:4d65cbadde173910",
"user_agent:luci-scheduler"
],
"updated_ts": "1594735861199790",
"url": "https://ci.chromium.org/b/8874804060485095776",
"utcnow_ts": "1594735862857917"
}
}
[14:11:02.876] Invocation finished in 3h12m17.693682445s with status SUCCEEDED