[19:58:22.284] New invocation is queued and will start shortly
[19:58:23.369] Starting the invocation (attempt 1)
[19:58:23.407] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:58:23.407] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:58:23.407] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065839114266104224",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b396582acc82e865779328f88ea7e6fd0c4db9ec\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9065839114266104224",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"gitiles_ref:refs/heads/master"
]
}
[19:58:24.299] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570305503702624",
"id": "8900409052108431360",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b396582acc82e865779328f88ea7e6fd0c4db9ec\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570305504161404",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14896",
"builder:Windows deterministic",
"buildset:commit/git/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065839114266104224",
"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/8900409052108431360/+/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": "1570305504161555",
"url": "https://ci.chromium.org/b/8900409052108431360",
"utcnow_ts": "1570305504289462"
}
}
[19:58:24.299] Task URL: https://ci.chromium.org/b/8900409052108431360
[19:58:24.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:2:0) after 1m0s
[19:58:26.272] Received PubSub notification, asking Buildbucket for the build status
[19:58:26.826] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:24.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:2:0)
[19:59:24.349] Timer tick, asking Buildbucket for the build status
[19:59:24.525] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:24.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:4:0) after 1m0s
[20:00:24.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:4:0)
[20:00:24.534] Timer tick, asking Buildbucket for the build status
[20:00:25.140] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:25.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:5:0) after 1m0s
[20:01:25.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:5:0)
[20:01:25.151] Timer tick, asking Buildbucket for the build status
[20:01:25.636] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:25.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:6:0) after 1m0s
[20:02:25.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:6:0)
[20:02:25.639] Timer tick, asking Buildbucket for the build status
[20:02:25.783] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:25.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:7:0) after 1m0s
[20:03:25.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:7:0)
[20:03:25.803] Timer tick, asking Buildbucket for the build status
[20:03:26.231] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:26.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:8:0) after 1m0s
[20:04:26.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:8:0)
[20:04:26.445] Timer tick, asking Buildbucket for the build status
[20:04:26.618] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:26.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:9:0) after 1m0s
[20:05:26.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:9:0)
[20:05:26.641] Timer tick, asking Buildbucket for the build status
[20:05:26.866] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:26.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:10:0) after 1m0s
[20:06:26.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:10:0)
[20:06:26.917] Timer tick, asking Buildbucket for the build status
[20:06:27.328] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:27.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:11:0) after 1m0s
[20:07:27.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:11:0)
[20:07:27.388] Timer tick, asking Buildbucket for the build status
[20:07:27.837] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:27.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:12:0) after 1m0s
[20:08:27.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:12:0)
[20:08:27.888] Timer tick, asking Buildbucket for the build status
[20:08:28.059] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:28.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:13:0) after 1m0s
[20:09:28.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:13:0)
[20:09:28.101] Timer tick, asking Buildbucket for the build status
[20:09:31.008] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:31.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:14:0) after 1m0s
[20:10:31.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:14:0)
[20:10:31.081] Timer tick, asking Buildbucket for the build status
[20:10:31.997] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:15:0) after 1m0s
[20:11:32.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:15:0)
[20:11:32.027] Timer tick, asking Buildbucket for the build status
[20:11:32.164] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:32.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:16:0) after 1m0s
[20:12:32.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:16:0)
[20:12:32.238] Timer tick, asking Buildbucket for the build status
[20:12:32.549] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:32.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:17:0) after 1m0s
[20:13:32.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:17:0)
[20:13:32.570] Timer tick, asking Buildbucket for the build status
[20:13:32.720] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:32.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:18:0) after 1m0s
[20:14:32.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:18:0)
[20:14:32.749] Timer tick, asking Buildbucket for the build status
[20:14:32.983] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:32.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:19:0) after 1m0s
[20:15:33.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:19:0)
[20:15:33.011] Timer tick, asking Buildbucket for the build status
[20:15:33.165] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:33.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:20:0) after 1m0s
[20:16:33.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:20:0)
[20:16:33.186] Timer tick, asking Buildbucket for the build status
[20:16:33.336] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:33.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:21:0) after 1m0s
[20:17:33.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:21:0)
[20:17:33.415] Timer tick, asking Buildbucket for the build status
[20:17:33.613] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:33.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:22:0) after 1m0s
[20:18:33.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:22:0)
[20:18:33.691] Timer tick, asking Buildbucket for the build status
[20:18:34.638] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:34.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:23:0) after 1m0s
[20:19:34.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:23:0)
[20:19:34.664] Timer tick, asking Buildbucket for the build status
[20:19:34.858] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:24:0) after 1m0s
[20:20:34.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:24:0)
[20:20:34.849] Timer tick, asking Buildbucket for the build status
[20:20:34.996] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:34.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:25:0) after 1m0s
[20:21:35.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:25:0)
[20:21:35.082] Timer tick, asking Buildbucket for the build status
[20:21:35.553] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:35.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:26:0) after 1m0s
[20:22:35.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:26:0)
[20:22:35.745] Timer tick, asking Buildbucket for the build status
[20:22:35.924] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:35.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:27:0) after 1m0s
[20:23:36.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:27:0)
[20:23:36.074] Timer tick, asking Buildbucket for the build status
[20:23:36.278] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:28:0) after 1m0s
[20:24:36.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:28:0)
[20:24:36.448] Timer tick, asking Buildbucket for the build status
[20:24:37.775] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:37.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:29:0) after 1m0s
[20:25:37.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:29:0)
[20:25:37.855] Timer tick, asking Buildbucket for the build status
[20:25:38.096] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:38.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:30:0) after 1m0s
[20:26:38.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:30:0)
[20:26:38.113] Timer tick, asking Buildbucket for the build status
[20:26:38.296] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:38.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:31:0) after 1m0s
[20:27:38.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:31:0)
[20:27:38.290] Timer tick, asking Buildbucket for the build status
[20:27:38.499] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:38.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:32:0) after 1m0s
[20:28:38.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:32:0)
[20:28:38.531] Timer tick, asking Buildbucket for the build status
[20:28:38.925] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:38.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:33:0) after 1m0s
[20:29:38.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:33:0)
[20:29:38.905] Timer tick, asking Buildbucket for the build status
[20:29:39.371] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:39.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:34:0) after 1m0s
[20:30:39.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:34:0)
[20:30:39.389] Timer tick, asking Buildbucket for the build status
[20:30:40.224] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:40.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:35:0) after 1m0s
[20:31:40.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:35:0)
[20:31:40.255] Timer tick, asking Buildbucket for the build status
[20:31:41.586] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:41.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:36:0) after 1m0s
[20:32:41.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:36:0)
[20:32:41.629] Timer tick, asking Buildbucket for the build status
[20:32:41.824] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:41.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:37:0) after 1m0s
[20:33:41.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:37:0)
[20:33:41.879] Timer tick, asking Buildbucket for the build status
[20:33:42.411] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:42.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:38:0) after 1m0s
[20:34:42.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:38:0)
[20:34:42.470] Timer tick, asking Buildbucket for the build status
[20:34:44.801] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:39:0) after 1m0s
[20:35:44.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:39:0)
[20:35:44.895] Timer tick, asking Buildbucket for the build status
[20:35:45.199] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:45.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:40:0) after 1m0s
[20:36:45.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:40:0)
[20:36:45.251] Timer tick, asking Buildbucket for the build status
[20:36:45.490] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:45.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:41:0) after 1m0s
[20:37:45.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:41:0)
[20:37:45.518] Timer tick, asking Buildbucket for the build status
[20:37:45.770] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:42:0) after 1m0s
[20:38:45.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:42:0)
[20:38:45.849] Timer tick, asking Buildbucket for the build status
[20:38:46.266] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:46.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:43:0) after 1m0s
[20:39:46.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:43:0)
[20:39:46.299] Timer tick, asking Buildbucket for the build status
[20:39:47.266] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:47.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:44:0) after 1m0s
[20:40:47.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:44:0)
[20:40:47.301] Timer tick, asking Buildbucket for the build status
[20:40:47.454] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:47.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:45:0) after 1m0s
[20:41:47.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:45:0)
[20:41:47.477] Timer tick, asking Buildbucket for the build status
[20:41:47.660] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:47.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:46:0) after 1m0s
[20:42:47.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:46:0)
[20:42:47.668] Timer tick, asking Buildbucket for the build status
[20:42:52.832] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:52.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:47:0) after 1m0s
[20:43:52.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:47:0)
[20:43:52.955] Timer tick, asking Buildbucket for the build status
[20:43:53.123] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:53.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:48:0) after 1m0s
[20:44:53.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:48:0)
[20:44:53.156] Timer tick, asking Buildbucket for the build status
[20:44:53.327] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:53.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:49:0) after 1m0s
[20:45:53.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:49:0)
[20:45:53.363] Timer tick, asking Buildbucket for the build status
[20:45:53.630] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:53.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:50:0) after 1m0s
[20:46:53.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:50:0)
[20:46:53.702] Timer tick, asking Buildbucket for the build status
[20:46:54.042] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:54.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:51:0) after 1m0s
[20:47:54.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:51:0)
[20:47:54.110] Timer tick, asking Buildbucket for the build status
[20:47:54.272] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:54.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:52:0) after 1m0s
[20:48:54.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:52:0)
[20:48:54.271] Timer tick, asking Buildbucket for the build status
[20:48:54.471] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:54.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:53:0) after 1m0s
[20:49:54.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:53:0)
[20:49:54.549] Timer tick, asking Buildbucket for the build status
[20:49:55.549] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:55.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:54:0) after 1m0s
[20:50:55.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:54:0)
[20:50:55.625] Timer tick, asking Buildbucket for the build status
[20:50:56.468] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:56.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:55:0) after 1m0s
[20:51:56.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:55:0)
[20:51:56.463] Timer tick, asking Buildbucket for the build status
[20:51:57.263] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:57.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:56:0) after 1m0s
[20:52:57.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:56:0)
[20:52:57.388] Timer tick, asking Buildbucket for the build status
[20:52:57.611] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:57.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:57:0) after 1m0s
[20:53:57.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:57:0)
[20:53:57.639] Timer tick, asking Buildbucket for the build status
[20:53:58.063] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:58.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:58:0) after 1m0s
[20:54:58.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:58:0)
[20:54:58.089] Timer tick, asking Buildbucket for the build status
[20:54:58.301] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:58.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:59:0) after 1m0s
[20:55:58.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:59:0)
[20:55:58.328] Timer tick, asking Buildbucket for the build status
[20:55:59.704] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:59.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:60:0) after 1m0s
[20:56:59.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:60:0)
[20:56:59.755] Timer tick, asking Buildbucket for the build status
[20:57:00.273] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:00.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:61:0) after 1m0s
[20:58:00.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:61:0)
[20:58:00.308] Timer tick, asking Buildbucket for the build status
[20:58:00.516] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:00.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:62:0) after 1m0s
[20:59:00.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:62:0)
[20:59:00.551] Timer tick, asking Buildbucket for the build status
[20:59:00.993] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:63:0) after 1m0s
[21:00:01.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:63:0)
[21:00:01.025] Timer tick, asking Buildbucket for the build status
[21:00:01.329] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:01.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:64:0) after 1m0s
[21:01:01.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:64:0)
[21:01:01.368] Timer tick, asking Buildbucket for the build status
[21:01:01.614] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:01.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:65:0) after 1m0s
[21:02:01.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:65:0)
[21:02:01.738] Timer tick, asking Buildbucket for the build status
[21:02:02.003] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:02.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:66:0) after 1m0s
[21:03:02.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:66:0)
[21:03:02.024] Timer tick, asking Buildbucket for the build status
[21:03:02.338] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:02.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:67:0) after 1m0s
[21:04:02.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:67:0)
[21:04:02.483] Timer tick, asking Buildbucket for the build status
[21:04:03.269] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:03.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:68:0) after 1m0s
[21:05:03.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:68:0)
[21:05:03.357] Timer tick, asking Buildbucket for the build status
[21:05:04.409] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:04.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:69:0) after 1m0s
[21:06:04.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:69:0)
[21:06:04.504] Timer tick, asking Buildbucket for the build status
[21:06:04.810] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:04.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:70:0) after 1m0s
[21:07:04.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:70:0)
[21:07:04.892] Timer tick, asking Buildbucket for the build status
[21:07:05.323] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:05.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:71:0) after 1m0s
[21:08:05.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:71:0)
[21:08:05.350] Timer tick, asking Buildbucket for the build status
[21:08:05.644] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:05.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:72:0) after 1m0s
[21:09:05.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:72:0)
[21:09:05.703] Timer tick, asking Buildbucket for the build status
[21:09:06.021] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:06.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:73:0) after 1m0s
[21:10:06.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:73:0)
[21:10:06.048] Timer tick, asking Buildbucket for the build status
[21:10:06.238] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:06.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:74:0) after 1m0s
[21:11:06.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:74:0)
[21:11:06.300] Timer tick, asking Buildbucket for the build status
[21:11:06.487] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:06.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:75:0) after 1m0s
[21:12:06.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:75:0)
[21:12:06.774] Timer tick, asking Buildbucket for the build status
[21:12:06.997] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:06.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:76:0) after 1m0s
[21:13:07.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:76:0)
[21:13:07.494] Timer tick, asking Buildbucket for the build status
[21:13:09.334] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:09.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:77:0) after 1m0s
[21:14:09.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:77:0)
[21:14:09.330] Timer tick, asking Buildbucket for the build status
[21:14:09.986] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:09.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:78:0) after 1m0s
[21:15:10.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:78:0)
[21:15:10.085] Timer tick, asking Buildbucket for the build status
[21:15:10.393] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:10.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:79:0) after 1m0s
[21:16:10.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:79:0)
[21:16:10.521] Timer tick, asking Buildbucket for the build status
[21:16:11.313] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:11.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:80:0) after 1m0s
[21:17:11.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:80:0)
[21:17:11.621] Timer tick, asking Buildbucket for the build status
[21:17:11.836] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:11.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:81:0) after 1m0s
[21:18:11.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:81:0)
[21:18:11.867] Timer tick, asking Buildbucket for the build status
[21:18:12.246] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:12.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:82:0) after 1m0s
[21:19:12.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:82:0)
[21:19:12.290] Timer tick, asking Buildbucket for the build status
[21:19:14.509] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:14.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:83:0) after 1m0s
[21:20:14.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:83:0)
[21:20:14.764] Timer tick, asking Buildbucket for the build status
[21:20:15.742] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:15.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:84:0) after 1m0s
[21:21:15.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:84:0)
[21:21:15.770] Timer tick, asking Buildbucket for the build status
[21:21:16.367] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:85:0) after 1m0s
[21:22:16.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:85:0)
[21:22:16.406] Timer tick, asking Buildbucket for the build status
[21:22:16.869] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:16.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:86:0) after 1m0s
[21:23:17.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:86:0)
[21:23:17.003] Timer tick, asking Buildbucket for the build status
[21:23:17.628] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:17.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:87:0) after 1m0s
[21:24:17.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:87:0)
[21:24:17.656] Timer tick, asking Buildbucket for the build status
[21:24:18.135] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:18.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:88:0) after 1m0s
[21:25:18.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:88:0)
[21:25:18.209] Timer tick, asking Buildbucket for the build status
[21:25:18.419] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:18.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:89:0) after 1m0s
[21:26:18.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:89:0)
[21:26:18.548] Timer tick, asking Buildbucket for the build status
[21:26:19.537] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:19.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:90:0) after 1m0s
[21:27:19.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:90:0)
[21:27:19.661] Timer tick, asking Buildbucket for the build status
[21:27:19.989] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:19.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:91:0) after 1m0s
[21:28:20.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:91:0)
[21:28:20.021] Timer tick, asking Buildbucket for the build status
[21:28:20.534] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:20.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:92:0) after 1m0s
[21:29:20.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:92:0)
[21:29:20.562] Timer tick, asking Buildbucket for the build status
[21:29:20.860] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:20.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:93:0) after 1m0s
[21:30:21.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:93:0)
[21:30:21.040] Timer tick, asking Buildbucket for the build status
[21:30:21.728] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:21.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:94:0) after 1m0s
[21:31:21.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:94:0)
[21:31:21.872] Timer tick, asking Buildbucket for the build status
[21:31:22.456] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:22.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:95:0) after 1m0s
[21:32:22.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:95:0)
[21:32:22.548] Timer tick, asking Buildbucket for the build status
[21:32:22.884] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:22.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:96:0) after 1m0s
[21:33:22.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:96:0)
[21:33:22.949] Timer tick, asking Buildbucket for the build status
[21:33:23.914] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:97:0) after 1m0s
[21:34:23.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:97:0)
[21:34:23.996] Timer tick, asking Buildbucket for the build status
[21:34:24.848] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:24.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:98:0) after 1m0s
[21:35:24.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:98:0)
[21:35:24.971] Timer tick, asking Buildbucket for the build status
[21:35:25.253] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:25.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:99:0) after 1m0s
[21:36:25.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:99:0)
[21:36:25.297] Timer tick, asking Buildbucket for the build status
[21:36:26.197] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:26.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:100:0) after 1m0s
[21:37:26.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:100:0)
[21:37:26.227] Timer tick, asking Buildbucket for the build status
[21:37:26.532] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:26.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:101:0) after 1m0s
[21:38:26.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:101:0)
[21:38:26.557] Timer tick, asking Buildbucket for the build status
[21:38:26.912] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:102:0) after 1m0s
[21:39:26.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:102:0)
[21:39:26.942] Timer tick, asking Buildbucket for the build status
[21:39:27.211] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:27.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:103:0) after 1m0s
[21:40:27.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:103:0)
[21:40:27.370] Timer tick, asking Buildbucket for the build status
[21:40:27.799] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:27.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:104:0) after 1m0s
[21:41:27.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:104:0)
[21:41:27.922] Timer tick, asking Buildbucket for the build status
[21:41:28.431] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:28.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:105:0) after 1m0s
[21:42:28.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:105:0)
[21:42:28.458] Timer tick, asking Buildbucket for the build status
[21:42:28.613] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:106:0) after 1m0s
[21:43:28.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:106:0)
[21:43:28.638] Timer tick, asking Buildbucket for the build status
[21:43:28.936] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:28.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:107:0) after 1m0s
[21:44:28.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:107:0)
[21:44:28.977] Timer tick, asking Buildbucket for the build status
[21:44:29.219] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:29.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:108:0) after 1m0s
[21:45:29.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:108:0)
[21:45:29.419] Timer tick, asking Buildbucket for the build status
[21:45:29.626] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:29.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:109:0) after 1m0s
[21:46:29.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:109:0)
[21:46:29.802] Timer tick, asking Buildbucket for the build status
[21:46:30.577] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:30.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:110:0) after 1m0s
[21:47:30.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:110:0)
[21:47:30.642] Timer tick, asking Buildbucket for the build status
[21:47:31.157] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:31.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:111:0) after 1m0s
[21:48:31.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:111:0)
[21:48:31.201] Timer tick, asking Buildbucket for the build status
[21:48:31.826] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:31.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:112:0) after 1m0s
[21:49:31.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:112:0)
[21:49:31.853] Timer tick, asking Buildbucket for the build status
[21:49:32.113] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:32.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:113:0) after 1m0s
[21:50:32.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:113:0)
[21:50:32.142] Timer tick, asking Buildbucket for the build status
[21:50:32.678] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:32.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:114:0) after 1m0s
[21:51:32.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:114:0)
[21:51:32.717] Timer tick, asking Buildbucket for the build status
[21:51:32.969] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:32.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:115:0) after 1m0s
[21:52:33.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:115:0)
[21:52:33.110] Timer tick, asking Buildbucket for the build status
[21:52:33.280] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:33.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:116:0) after 1m0s
[21:53:33.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:116:0)
[21:53:33.360] Timer tick, asking Buildbucket for the build status
[21:53:34.395] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:34.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:117:0) after 1m0s
[21:54:34.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:117:0)
[21:54:34.379] Timer tick, asking Buildbucket for the build status
[21:54:35.147] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:35.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:118:0) after 1m0s
[21:55:35.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:118:0)
[21:55:35.177] Timer tick, asking Buildbucket for the build status
[21:55:35.445] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:35.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:119:0) after 1m0s
[21:56:35.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:119:0)
[21:56:35.476] Timer tick, asking Buildbucket for the build status
[21:56:35.630] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:120:0) after 1m0s
[21:57:35.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:120:0)
[21:57:35.659] Timer tick, asking Buildbucket for the build status
[21:57:35.834] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:35.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:121:0) after 1m0s
[21:58:35.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:121:0)
[21:58:35.862] Timer tick, asking Buildbucket for the build status
[21:58:36.087] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:36.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:122:0) after 1m0s
[21:59:36.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:122:0)
[21:59:36.120] Timer tick, asking Buildbucket for the build status
[21:59:36.301] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:36.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:123:0) after 1m0s
[22:00:36.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:123:0)
[22:00:36.395] Timer tick, asking Buildbucket for the build status
[22:00:36.582] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:36.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:124:0) after 1m0s
[22:01:36.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:124:0)
[22:01:36.610] Timer tick, asking Buildbucket for the build status
[22:01:36.925] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:36.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:125:0) after 1m0s
[22:02:36.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:125:0)
[22:02:36.952] Timer tick, asking Buildbucket for the build status
[22:02:37.138] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:37.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:126:0) after 1m0s
[22:03:37.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:126:0)
[22:03:37.165] Timer tick, asking Buildbucket for the build status
[22:03:37.366] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:37.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:127:0) after 1m0s
[22:04:37.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:127:0)
[22:04:37.392] Timer tick, asking Buildbucket for the build status
[22:04:37.634] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:37.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:128:0) after 1m0s
[22:05:37.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:128:0)
[22:05:37.689] Timer tick, asking Buildbucket for the build status
[22:05:38.726] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:38.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:129:0) after 1m0s
[22:06:38.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:129:0)
[22:06:38.808] Timer tick, asking Buildbucket for the build status
[22:06:39.094] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:39.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:130:0) after 1m0s
[22:07:39.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:130:0)
[22:07:39.121] Timer tick, asking Buildbucket for the build status
[22:07:39.398] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:39.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:131:0) after 1m0s
[22:08:39.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:131:0)
[22:08:39.438] Timer tick, asking Buildbucket for the build status
[22:08:39.648] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:39.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:132:0) after 1m0s
[22:09:39.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:132:0)
[22:09:39.800] Timer tick, asking Buildbucket for the build status
[22:09:39.938] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:39.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:133:0) after 1m0s
[22:10:40.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:133:0)
[22:10:40.058] Timer tick, asking Buildbucket for the build status
[22:10:40.316] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:40.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:134:0) after 1m0s
[22:11:40.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:134:0)
[22:11:40.470] Timer tick, asking Buildbucket for the build status
[22:11:40.834] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:40.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:135:0) after 1m0s
[22:12:40.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:135:0)
[22:12:40.924] Timer tick, asking Buildbucket for the build status
[22:12:41.135] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:41.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:136:0) after 1m0s
[22:13:41.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:136:0)
[22:13:41.210] Timer tick, asking Buildbucket for the build status
[22:13:41.432] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:41.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:137:0) after 1m0s
[22:14:41.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:137:0)
[22:14:41.465] Timer tick, asking Buildbucket for the build status
[22:14:41.652] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:41.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:138:0) after 1m0s
[22:15:41.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:138:0)
[22:15:41.729] Timer tick, asking Buildbucket for the build status
[22:15:42.007] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:42.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:139:0) after 1m0s
[22:16:42.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:139:0)
[22:16:42.042] Timer tick, asking Buildbucket for the build status
[22:16:42.318] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:42.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:140:0) after 1m0s
[22:17:42.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:140:0)
[22:17:42.385] Timer tick, asking Buildbucket for the build status
[22:17:42.644] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:42.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:141:0) after 1m0s
[22:18:42.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:141:0)
[22:18:42.878] Timer tick, asking Buildbucket for the build status
[22:18:43.078] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:43.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:142:0) after 1m0s
[22:19:43.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:142:0)
[22:19:43.340] Timer tick, asking Buildbucket for the build status
[22:19:44.218] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:44.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:143:0) after 1m0s
[22:20:44.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:143:0)
[22:20:44.245] Timer tick, asking Buildbucket for the build status
[22:20:44.440] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:44.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:144:0) after 1m0s
[22:21:44.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:144:0)
[22:21:44.539] Timer tick, asking Buildbucket for the build status
[22:21:45.688] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:45.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:145:0) after 1m0s
[22:22:45.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:145:0)
[22:22:45.727] Timer tick, asking Buildbucket for the build status
[22:22:46.488] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:46.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:146:0) after 1m0s
[22:23:46.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:146:0)
[22:23:46.520] Timer tick, asking Buildbucket for the build status
[22:23:47.131] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:47.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:147:0) after 1m0s
[22:24:47.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:147:0)
[22:24:47.158] Timer tick, asking Buildbucket for the build status
[22:24:47.681] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:148:0) after 1m0s
[22:25:47.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:148:0)
[22:25:47.713] Timer tick, asking Buildbucket for the build status
[22:25:48.107] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:48.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:149:0) after 1m0s
[22:26:48.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:149:0)
[22:26:48.141] Timer tick, asking Buildbucket for the build status
[22:26:49.059] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:49.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:150:0) after 1m0s
[22:27:49.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:150:0)
[22:27:49.105] Timer tick, asking Buildbucket for the build status
[22:27:49.288] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:49.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:151:0) after 1m0s
[22:28:49.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:151:0)
[22:28:49.322] Timer tick, asking Buildbucket for the build status
[22:28:49.529] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:49.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:152:0) after 1m0s
[22:29:49.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:152:0)
[22:29:49.556] Timer tick, asking Buildbucket for the build status
[22:29:50.483] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:50.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:153:0) after 1m0s
[22:30:50.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:153:0)
[22:30:50.515] Timer tick, asking Buildbucket for the build status
[22:30:50.762] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:50.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:154:0) after 1m0s
[22:31:50.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:154:0)
[22:31:50.799] Timer tick, asking Buildbucket for the build status
[22:31:51.068] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:51.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:155:0) after 1m0s
[22:32:51.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:155:0)
[22:32:51.121] Timer tick, asking Buildbucket for the build status
[22:32:51.351] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:51.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:156:0) after 1m0s
[22:33:51.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:156:0)
[22:33:51.376] Timer tick, asking Buildbucket for the build status
[22:33:51.538] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:51.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:157:0) after 1m0s
[22:34:51.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:157:0)
[22:34:51.571] Timer tick, asking Buildbucket for the build status
[22:34:51.797] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:51.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:158:0) after 1m0s
[22:35:51.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:158:0)
[22:35:51.826] Timer tick, asking Buildbucket for the build status
[22:35:51.959] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:51.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:159:0) after 1m0s
[22:36:51.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:159:0)
[22:36:51.983] Timer tick, asking Buildbucket for the build status
[22:36:52.155] Build 8900409052108431360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:52.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065839114266104224:160:0) after 1m0s
[22:37:14.493] Received PubSub notification, asking Buildbucket for the build status
[22:37:14.620] Build 8900409052108431360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:37:14.620] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570315033740329",
"created_by": "project:chromium",
"created_ts": "1570305503702624",
"id": "8900409052108431360",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b396582acc82e865779328f88ea7e6fd0c4db9ec\"}}",
"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-kun4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14896, \"got_angle_revision\": \"5e9d4ee99ea11265ac48cdc41cc60480f37e4f02\", \"got_dawn_revision\": \"21dfc919547fb3b139b56271d1aa09518bd75801\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b396582acc82e865779328f88ea7e6fd0c4db9ec\", \"got_revision_cp\": \"refs/heads/master@{#703160}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"d59e86cad68a0cbe50b36219614685fe1811804b\", \"got_v8_revision_cp\": \"refs/heads/7.9.218@{#1}\", \"got_webrtc_revision\": \"b441acf656520aa6ff9d8864b0aa1b065f1771c8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29389}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b396582acc82e865779328f88ea7e6fd0c4db9ec\"}, \"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-kun4\"], \"image\": [\"chrome-win10-1703-19091300-a244b1e46d2\"], \"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\": [\"4466-755d6a2\"], \"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": "1570305505487561",
"status": "COMPLETED",
"status_changed_ts": "1570315034094999",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14896",
"builder:Windows deterministic",
"buildset:commit/git/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b396582acc82e865779328f88ea7e6fd0c4db9ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065839114266104224",
"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/8900409052108431360/+/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:47b651fdc9c2a210",
"user_agent:luci-scheduler"
],
"updated_ts": "1570315034101946",
"url": "https://ci.chromium.org/b/8900409052108431360",
"utcnow_ts": "1570315034612991"
}
}
[22:37:14.620] Invocation finished in 2h38m52.359084813s with status SUCCEEDED