[04:43:00.713] New invocation is queued and will start shortly
[04:43:01.818] Starting the invocation (attempt 1)
[04:43:01.860] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:43:01.860] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:43:01.860] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072510282289226528",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4e5862813fc528b31bab37e68f4ec65cb2c1ac54\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9072510282289226528",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"gitiles_ref:refs/heads/master"
]
}
[04:43:02.710] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563943382011327",
"id": "8907080220222576864",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4e5862813fc528b31bab37e68f4ec65cb2c1ac54\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563943382543864",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14221",
"builder:Windows deterministic",
"buildset:commit/git/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072510282289226528",
"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/8907080220222576864/+/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": "1563943382544018",
"url": "https://ci.chromium.org/b/8907080220222576864",
"utcnow_ts": "1563943382699154"
}
}
[04:43:02.710] Task URL: https://ci.chromium.org/b/8907080220222576864
[04:43:02.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:2:0) after 1m0s
[04:43:04.893] Received PubSub notification, asking Buildbucket for the build status
[04:43:05.186] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:02.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:2:0)
[04:44:02.793] Timer tick, asking Buildbucket for the build status
[04:44:03.110] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:03.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:4:0) after 1m0s
[04:45:03.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:4:0)
[04:45:03.141] Timer tick, asking Buildbucket for the build status
[04:45:03.278] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:03.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:5:0) after 1m0s
[04:46:03.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:5:0)
[04:46:03.302] Timer tick, asking Buildbucket for the build status
[04:46:03.419] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:03.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:6:0) after 1m0s
[04:47:03.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:6:0)
[04:47:03.470] Timer tick, asking Buildbucket for the build status
[04:47:03.618] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:03.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:7:0) after 1m0s
[04:48:03.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:7:0)
[04:48:03.667] Timer tick, asking Buildbucket for the build status
[04:48:03.983] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:03.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:8:0) after 1m0s
[04:49:04.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:8:0)
[04:49:04.004] Timer tick, asking Buildbucket for the build status
[04:49:04.322] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:9:0) after 1m0s
[04:50:04.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:9:0)
[04:50:04.345] Timer tick, asking Buildbucket for the build status
[04:50:04.899] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:04.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:10:0) after 1m0s
[04:51:04.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:10:0)
[04:51:04.974] Timer tick, asking Buildbucket for the build status
[04:51:05.870] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:11:0) after 1m0s
[04:52:05.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:11:0)
[04:52:05.960] Timer tick, asking Buildbucket for the build status
[04:52:06.485] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:06.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:12:0) after 1m0s
[04:53:06.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:12:0)
[04:53:06.506] Timer tick, asking Buildbucket for the build status
[04:53:06.791] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:13:0) after 1m0s
[04:54:06.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:13:0)
[04:54:06.908] Timer tick, asking Buildbucket for the build status
[04:54:07.120] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:07.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:14:0) after 1m0s
[04:55:07.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:14:0)
[04:55:07.162] Timer tick, asking Buildbucket for the build status
[04:55:07.356] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:07.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:15:0) after 1m0s
[04:56:07.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:15:0)
[04:56:07.484] Timer tick, asking Buildbucket for the build status
[04:56:07.585] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:07.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:16:0) after 1m0s
[04:57:07.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:16:0)
[04:57:07.618] Timer tick, asking Buildbucket for the build status
[04:57:08.314] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:08.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:17:0) after 1m0s
[04:58:08.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:17:0)
[04:58:08.363] Timer tick, asking Buildbucket for the build status
[04:58:08.944] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:08.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:18:0) after 1m0s
[04:59:09.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:18:0)
[04:59:09.045] Timer tick, asking Buildbucket for the build status
[04:59:09.269] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:09.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:19:0) after 1m0s
[05:00:09.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:19:0)
[05:00:09.300] Timer tick, asking Buildbucket for the build status
[05:00:09.553] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:09.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:20:0) after 1m0s
[05:01:09.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:20:0)
[05:01:09.543] Timer tick, asking Buildbucket for the build status
[05:01:10.387] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:10.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:21:0) after 1m0s
[05:02:10.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:21:0)
[05:02:10.513] Timer tick, asking Buildbucket for the build status
[05:02:10.686] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:22:0) after 1m0s
[05:03:10.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:22:0)
[05:03:10.735] Timer tick, asking Buildbucket for the build status
[05:03:10.905] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:10.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:23:0) after 1m0s
[05:04:10.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:23:0)
[05:04:10.978] Timer tick, asking Buildbucket for the build status
[05:04:11.405] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:11.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:24:0) after 1m0s
[05:05:11.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:24:0)
[05:05:11.468] Timer tick, asking Buildbucket for the build status
[05:05:11.674] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:11.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:25:0) after 1m0s
[05:06:11.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:25:0)
[05:06:11.701] Timer tick, asking Buildbucket for the build status
[05:06:11.896] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:11.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:26:0) after 1m0s
[05:07:11.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:26:0)
[05:07:11.931] Timer tick, asking Buildbucket for the build status
[05:07:12.308] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:12.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:27:0) after 1m0s
[05:08:12.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:27:0)
[05:08:12.343] Timer tick, asking Buildbucket for the build status
[05:08:12.658] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:12.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:28:0) after 1m0s
[05:09:12.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:28:0)
[05:09:12.683] Timer tick, asking Buildbucket for the build status
[05:09:14.164] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:14.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:29:0) after 1m0s
[05:10:14.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:29:0)
[05:10:14.195] Timer tick, asking Buildbucket for the build status
[05:10:15.118] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:15.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:30:0) after 1m0s
[05:11:15.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:30:0)
[05:11:15.143] Timer tick, asking Buildbucket for the build status
[05:11:16.020] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:16.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:31:0) after 1m0s
[05:12:16.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:31:0)
[05:12:16.051] Timer tick, asking Buildbucket for the build status
[05:12:16.191] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:16.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:32:0) after 1m0s
[05:13:16.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:32:0)
[05:13:16.254] Timer tick, asking Buildbucket for the build status
[05:13:16.752] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:16.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:33:0) after 1m0s
[05:14:16.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:33:0)
[05:14:16.837] Timer tick, asking Buildbucket for the build status
[05:14:17.101] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:17.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:34:0) after 1m0s
[05:15:17.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:34:0)
[05:15:17.083] Timer tick, asking Buildbucket for the build status
[05:15:17.295] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:17.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:35:0) after 1m0s
[05:16:17.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:35:0)
[05:16:17.324] Timer tick, asking Buildbucket for the build status
[05:16:18.007] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:18.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:36:0) after 1m0s
[05:17:18.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:36:0)
[05:17:18.044] Timer tick, asking Buildbucket for the build status
[05:17:18.711] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:18.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:37:0) after 1m0s
[05:18:18.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:37:0)
[05:18:18.762] Timer tick, asking Buildbucket for the build status
[05:18:19.315] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:19.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:38:0) after 1m0s
[05:19:19.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:38:0)
[05:19:19.345] Timer tick, asking Buildbucket for the build status
[05:19:19.669] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:19.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:39:0) after 1m0s
[05:20:19.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:39:0)
[05:20:19.681] Timer tick, asking Buildbucket for the build status
[05:20:20.467] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:20.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:40:0) after 1m0s
[05:21:20.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:40:0)
[05:21:20.492] Timer tick, asking Buildbucket for the build status
[05:21:20.720] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:20.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:41:0) after 1m0s
[05:22:20.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:41:0)
[05:22:20.772] Timer tick, asking Buildbucket for the build status
[05:22:21.326] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:21.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:42:0) after 1m0s
[05:23:21.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:42:0)
[05:23:21.337] Timer tick, asking Buildbucket for the build status
[05:23:21.703] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:43:0) after 1m0s
[05:24:21.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:43:0)
[05:24:21.734] Timer tick, asking Buildbucket for the build status
[05:24:21.963] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:21.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:44:0) after 1m0s
[05:25:21.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:44:0)
[05:25:21.987] Timer tick, asking Buildbucket for the build status
[05:25:22.325] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:22.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:45:0) after 1m0s
[05:26:22.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:45:0)
[05:26:22.440] Timer tick, asking Buildbucket for the build status
[05:26:23.392] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:23.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:46:0) after 1m0s
[05:27:23.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:46:0)
[05:27:23.395] Timer tick, asking Buildbucket for the build status
[05:27:23.952] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:23.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:47:0) after 1m0s
[05:28:23.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:47:0)
[05:28:23.990] Timer tick, asking Buildbucket for the build status
[05:28:24.212] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:24.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:48:0) after 1m0s
[05:29:24.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:48:0)
[05:29:24.241] Timer tick, asking Buildbucket for the build status
[05:29:24.447] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:24.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:49:0) after 1m0s
[05:30:24.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:49:0)
[05:30:24.500] Timer tick, asking Buildbucket for the build status
[05:30:24.742] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:24.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:50:0) after 1m0s
[05:31:24.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:50:0)
[05:31:24.818] Timer tick, asking Buildbucket for the build status
[05:31:25.199] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:25.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:51:0) after 1m0s
[05:32:25.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:51:0)
[05:32:25.248] Timer tick, asking Buildbucket for the build status
[05:32:25.429] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:25.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:52:0) after 1m0s
[05:33:25.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:52:0)
[05:33:25.578] Timer tick, asking Buildbucket for the build status
[05:33:26.483] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:53:0) after 1m0s
[05:34:26.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:53:0)
[05:34:26.653] Timer tick, asking Buildbucket for the build status
[05:34:27.397] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:27.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:54:0) after 1m0s
[05:35:27.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:54:0)
[05:35:27.529] Timer tick, asking Buildbucket for the build status
[05:35:28.210] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:28.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:55:0) after 1m0s
[05:36:28.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:55:0)
[05:36:28.342] Timer tick, asking Buildbucket for the build status
[05:36:29.135] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:29.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:56:0) after 1m0s
[05:37:29.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:56:0)
[05:37:29.141] Timer tick, asking Buildbucket for the build status
[05:37:30.345] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:30.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:57:0) after 1m0s
[05:38:31.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:57:0)
[05:38:31.143] Timer tick, asking Buildbucket for the build status
[05:38:31.741] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:31.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:58:0) after 1m0s
[05:39:31.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:58:0)
[05:39:31.732] Timer tick, asking Buildbucket for the build status
[05:39:31.874] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:31.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:59:0) after 1m0s
[05:40:32.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:59:0)
[05:40:32.410] Timer tick, asking Buildbucket for the build status
[05:40:32.924] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:32.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:60:0) after 1m0s
[05:41:33.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:60:0)
[05:41:33.049] Timer tick, asking Buildbucket for the build status
[05:41:33.483] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:33.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:61:0) after 1m0s
[05:42:34.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:61:0)
[05:42:34.332] Timer tick, asking Buildbucket for the build status
[05:42:34.901] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:34.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:62:0) after 1m0s
[05:43:35.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:62:0)
[05:43:35.273] Timer tick, asking Buildbucket for the build status
[05:43:35.434] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:35.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:63:0) after 1m0s
[05:44:35.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:63:0)
[05:44:35.618] Timer tick, asking Buildbucket for the build status
[05:44:36.301] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:36.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:64:0) after 1m0s
[05:45:36.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:64:0)
[05:45:36.483] Timer tick, asking Buildbucket for the build status
[05:45:36.669] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:65:0) after 1m0s
[05:46:36.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:65:0)
[05:46:36.760] Timer tick, asking Buildbucket for the build status
[05:46:39.578] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:39.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:66:0) after 1m0s
[05:47:40.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:66:0)
[05:47:40.006] Timer tick, asking Buildbucket for the build status
[05:47:40.314] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:40.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:67:0) after 1m0s
[05:48:40.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:67:0)
[05:48:40.335] Timer tick, asking Buildbucket for the build status
[05:48:40.830] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:40.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:68:0) after 1m0s
[05:49:40.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:68:0)
[05:49:40.943] Timer tick, asking Buildbucket for the build status
[05:49:41.147] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:41.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:69:0) after 1m0s
[05:50:41.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:69:0)
[05:50:41.276] Timer tick, asking Buildbucket for the build status
[05:50:41.907] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:70:0) after 1m0s
[05:51:42.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:70:0)
[05:51:42.167] Timer tick, asking Buildbucket for the build status
[05:51:42.305] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:42.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:71:0) after 1m0s
[05:52:42.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:71:0)
[05:52:42.382] Timer tick, asking Buildbucket for the build status
[05:52:42.640] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:42.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:72:0) after 1m0s
[05:53:42.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:72:0)
[05:53:42.859] Timer tick, asking Buildbucket for the build status
[05:53:43.665] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:43.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:73:0) after 1m0s
[05:54:43.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:73:0)
[05:54:43.753] Timer tick, asking Buildbucket for the build status
[05:54:44.021] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:74:0) after 1m0s
[05:55:44.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:74:0)
[05:55:44.163] Timer tick, asking Buildbucket for the build status
[05:55:45.127] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:45.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:75:0) after 1m0s
[05:56:45.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:75:0)
[05:56:45.286] Timer tick, asking Buildbucket for the build status
[05:56:45.946] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:45.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:76:0) after 1m0s
[05:57:46.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:76:0)
[05:57:46.068] Timer tick, asking Buildbucket for the build status
[05:57:46.244] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:46.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:77:0) after 1m0s
[05:58:46.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:77:0)
[05:58:46.318] Timer tick, asking Buildbucket for the build status
[05:58:46.636] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:46.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:78:0) after 1m0s
[05:59:46.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:78:0)
[05:59:46.817] Timer tick, asking Buildbucket for the build status
[05:59:47.658] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:47.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:79:0) after 1m0s
[06:00:47.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:79:0)
[06:00:47.737] Timer tick, asking Buildbucket for the build status
[06:00:48.213] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:48.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:80:0) after 1m0s
[06:01:48.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:80:0)
[06:01:48.271] Timer tick, asking Buildbucket for the build status
[06:01:48.724] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:48.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:81:0) after 1m0s
[06:02:48.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:81:0)
[06:02:48.834] Timer tick, asking Buildbucket for the build status
[06:02:49.298] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:49.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:82:0) after 1m0s
[06:03:49.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:82:0)
[06:03:49.339] Timer tick, asking Buildbucket for the build status
[06:03:49.526] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:83:0) after 1m0s
[06:04:49.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:83:0)
[06:04:49.529] Timer tick, asking Buildbucket for the build status
[06:04:49.729] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:84:0) after 1m0s
[06:05:49.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:84:0)
[06:05:49.790] Timer tick, asking Buildbucket for the build status
[06:05:49.972] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:85:0) after 1m0s
[06:06:50.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:85:0)
[06:06:50.032] Timer tick, asking Buildbucket for the build status
[06:06:52.803] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:52.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:86:0) after 1m0s
[06:07:52.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:86:0)
[06:07:52.856] Timer tick, asking Buildbucket for the build status
[06:07:53.002] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:53.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:87:0) after 1m0s
[06:08:53.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:87:0)
[06:08:53.035] Timer tick, asking Buildbucket for the build status
[06:08:54.556] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:54.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:88:0) after 1m0s
[06:09:54.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:88:0)
[06:09:54.650] Timer tick, asking Buildbucket for the build status
[06:09:57.245] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:57.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:89:0) after 1m0s
[06:10:57.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:89:0)
[06:10:57.363] Timer tick, asking Buildbucket for the build status
[06:10:57.745] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:57.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:90:0) after 1m0s
[06:11:57.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:90:0)
[06:11:57.886] Timer tick, asking Buildbucket for the build status
[06:11:58.536] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:58.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:91:0) after 1m0s
[06:12:58.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:91:0)
[06:12:58.642] Timer tick, asking Buildbucket for the build status
[06:13:00.269] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:00.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:92:0) after 1m0s
[06:14:00.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:92:0)
[06:14:00.447] Timer tick, asking Buildbucket for the build status
[06:14:00.649] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:00.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:93:0) after 1m0s
[06:15:00.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:93:0)
[06:15:00.697] Timer tick, asking Buildbucket for the build status
[06:15:00.882] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:00.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:94:0) after 1m0s
[06:16:01.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:94:0)
[06:16:01.006] Timer tick, asking Buildbucket for the build status
[06:16:01.207] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:01.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:95:0) after 1m0s
[06:17:01.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:95:0)
[06:17:01.303] Timer tick, asking Buildbucket for the build status
[06:17:01.464] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:01.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:96:0) after 1m0s
[06:18:01.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:96:0)
[06:18:01.497] Timer tick, asking Buildbucket for the build status
[06:18:02.453] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:02.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:97:0) after 1m0s
[06:19:02.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:97:0)
[06:19:02.560] Timer tick, asking Buildbucket for the build status
[06:19:02.716] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:02.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:98:0) after 1m0s
[06:20:02.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:98:0)
[06:20:02.731] Timer tick, asking Buildbucket for the build status
[06:20:03.110] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:03.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:99:0) after 1m0s
[06:21:03.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:99:0)
[06:21:03.305] Timer tick, asking Buildbucket for the build status
[06:21:03.634] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:03.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:100:0) after 1m0s
[06:22:03.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:100:0)
[06:22:03.686] Timer tick, asking Buildbucket for the build status
[06:22:04.125] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:04.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:101:0) after 1m0s
[06:23:04.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:101:0)
[06:23:04.164] Timer tick, asking Buildbucket for the build status
[06:23:04.937] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:04.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:102:0) after 1m0s
[06:24:05.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:102:0)
[06:24:05.087] Timer tick, asking Buildbucket for the build status
[06:24:05.298] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:05.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:103:0) after 1m0s
[06:25:05.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:103:0)
[06:25:05.354] Timer tick, asking Buildbucket for the build status
[06:25:05.809] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:05.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:104:0) after 1m0s
[06:26:05.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:104:0)
[06:26:05.918] Timer tick, asking Buildbucket for the build status
[06:26:06.135] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:06.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:105:0) after 1m0s
[06:27:06.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:105:0)
[06:27:06.202] Timer tick, asking Buildbucket for the build status
[06:27:07.151] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:07.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:106:0) after 1m0s
[06:28:07.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:106:0)
[06:28:07.218] Timer tick, asking Buildbucket for the build status
[06:28:09.444] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:09.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:107:0) after 1m0s
[06:29:09.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:107:0)
[06:29:09.461] Timer tick, asking Buildbucket for the build status
[06:29:09.653] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:09.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:108:0) after 1m0s
[06:30:09.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:108:0)
[06:30:09.684] Timer tick, asking Buildbucket for the build status
[06:30:11.162] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:11.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:109:0) after 1m0s
[06:31:11.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:109:0)
[06:31:11.191] Timer tick, asking Buildbucket for the build status
[06:31:12.096] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:12.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:110:0) after 1m0s
[06:32:12.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:110:0)
[06:32:12.175] Timer tick, asking Buildbucket for the build status
[06:32:12.294] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:12.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:111:0) after 1m0s
[06:33:12.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:111:0)
[06:33:12.428] Timer tick, asking Buildbucket for the build status
[06:33:12.628] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:12.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:112:0) after 1m0s
[06:34:12.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:112:0)
[06:34:12.646] Timer tick, asking Buildbucket for the build status
[06:34:13.639] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:13.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:113:0) after 1m0s
[06:35:13.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:113:0)
[06:35:13.630] Timer tick, asking Buildbucket for the build status
[06:35:15.142] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:114:0) after 1m0s
[06:36:15.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:114:0)
[06:36:15.208] Timer tick, asking Buildbucket for the build status
[06:36:15.409] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:15.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:115:0) after 1m0s
[06:37:15.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:115:0)
[06:37:15.533] Timer tick, asking Buildbucket for the build status
[06:37:16.268] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:16.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:116:0) after 1m0s
[06:38:16.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:116:0)
[06:38:16.564] Timer tick, asking Buildbucket for the build status
[06:38:17.044] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:17.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:117:0) after 1m0s
[06:39:17.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:117:0)
[06:39:17.296] Timer tick, asking Buildbucket for the build status
[06:39:17.815] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:17.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:118:0) after 1m0s
[06:40:17.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:118:0)
[06:40:17.890] Timer tick, asking Buildbucket for the build status
[06:40:18.998] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:18.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:119:0) after 1m0s
[06:41:19.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:119:0)
[06:41:19.032] Timer tick, asking Buildbucket for the build status
[06:41:19.351] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:19.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:120:0) after 1m0s
[06:42:19.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:120:0)
[06:42:19.387] Timer tick, asking Buildbucket for the build status
[06:42:19.695] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:19.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:121:0) after 1m0s
[06:43:19.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:121:0)
[06:43:19.749] Timer tick, asking Buildbucket for the build status
[06:43:19.941] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:19.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:122:0) after 1m0s
[06:44:20.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:122:0)
[06:44:20.006] Timer tick, asking Buildbucket for the build status
[06:44:21.562] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:21.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:123:0) after 1m0s
[06:45:21.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:123:0)
[06:45:21.594] Timer tick, asking Buildbucket for the build status
[06:45:23.704] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:23.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:124:0) after 1m0s
[06:46:23.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:124:0)
[06:46:23.846] Timer tick, asking Buildbucket for the build status
[06:46:24.021] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:24.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:125:0) after 1m0s
[06:47:24.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:125:0)
[06:47:24.085] Timer tick, asking Buildbucket for the build status
[06:47:24.374] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:24.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:126:0) after 1m0s
[06:48:24.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:126:0)
[06:48:24.438] Timer tick, asking Buildbucket for the build status
[06:48:24.831] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:24.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:127:0) after 1m0s
[06:49:24.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:127:0)
[06:49:24.896] Timer tick, asking Buildbucket for the build status
[06:49:25.189] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:25.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:128:0) after 1m0s
[06:50:25.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:128:0)
[06:50:25.261] Timer tick, asking Buildbucket for the build status
[06:50:25.460] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:129:0) after 1m0s
[06:51:25.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:129:0)
[06:51:25.598] Timer tick, asking Buildbucket for the build status
[06:51:25.741] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:25.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:130:0) after 1m0s
[06:52:25.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:130:0)
[06:52:25.744] Timer tick, asking Buildbucket for the build status
[06:52:25.940] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:25.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:131:0) after 1m0s
[06:53:25.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:131:0)
[06:53:25.934] Timer tick, asking Buildbucket for the build status
[06:53:26.779] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:26.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:132:0) after 1m0s
[06:54:26.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:132:0)
[06:54:26.939] Timer tick, asking Buildbucket for the build status
[06:54:27.149] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:27.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:133:0) after 1m0s
[06:55:27.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:133:0)
[06:55:27.300] Timer tick, asking Buildbucket for the build status
[06:55:27.434] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:27.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:134:0) after 1m0s
[06:56:27.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:134:0)
[06:56:27.508] Timer tick, asking Buildbucket for the build status
[06:56:29.978] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:29.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:135:0) after 1m0s
[06:57:30.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:135:0)
[06:57:30.007] Timer tick, asking Buildbucket for the build status
[06:57:30.170] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:30.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:136:0) after 1m0s
[06:58:30.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:136:0)
[06:58:30.309] Timer tick, asking Buildbucket for the build status
[06:58:31.073] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:31.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:137:0) after 1m0s
[06:59:31.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:137:0)
[06:59:31.120] Timer tick, asking Buildbucket for the build status
[06:59:32.165] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:32.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:138:0) after 1m0s
[07:00:32.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:138:0)
[07:00:32.356] Timer tick, asking Buildbucket for the build status
[07:00:33.472] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:33.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:139:0) after 1m0s
[07:01:33.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:139:0)
[07:01:33.536] Timer tick, asking Buildbucket for the build status
[07:01:33.690] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:33.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:140:0) after 1m0s
[07:02:33.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:140:0)
[07:02:33.911] Timer tick, asking Buildbucket for the build status
[07:02:34.205] Build 8907080220222576864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:34.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072510282289226528:141:0) after 1m0s
[07:03:07.223] Received PubSub notification, asking Buildbucket for the build status
[07:03:07.943] Build 8907080220222576864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:03:07.943] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563951783877786",
"created_by": "project:chromium",
"created_ts": "1563943382011327",
"id": "8907080220222576864",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4e5862813fc528b31bab37e68f4ec65cb2c1ac54\"}}",
"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-so9v\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14221, \"got_angle_revision\": \"8bb46c5b9ffc89e3d5eeddcd990fd69bb4cbeecd\", \"got_dawn_revision\": \"8944f0205b04fa5fe396e6f5e4c9298370f96acb\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"4e5862813fc528b31bab37e68f4ec65cb2c1ac54\", \"got_revision_cp\": \"refs/heads/master@{#680322}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"4035531228d69a8e3ec475ef75b51db302e70473\", \"got_v8_revision_cp\": \"refs/heads/7.7.299@{#1}\", \"got_webrtc_revision\": \"cfefa0aef329aac0206c5e56efd90b3b0bdb88b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28646}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4e5862813fc528b31bab37e68f4ec65cb2c1ac54\"}, \"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-so9v\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563943383674288",
"status": "COMPLETED",
"status_changed_ts": "1563951785490162",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14221",
"builder:Windows deterministic",
"buildset:commit/git/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5862813fc528b31bab37e68f4ec65cb2c1ac54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072510282289226528",
"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/8907080220222576864/+/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:463b1bb81d933b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1563951785545581",
"url": "https://ci.chromium.org/b/8907080220222576864",
"utcnow_ts": "1563951787927692"
}
}
[07:03:07.943] Invocation finished in 2h20m7.285894506s with status SUCCEEDED