[03:45:36.162] New invocation is queued and will start shortly
[03:45:37.216] Starting the invocation (attempt 1)
[03:45:37.252] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:45:37.253] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:45:37.253] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9082660754369469104",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"492b866a2776db106c6205fa1668412f48d4bf9b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9082660754369469104",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/492b866a2776db106c6205fa1668412f48d4bf9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/492b866a2776db106c6205fa1668412f48d4bf9b",
"gitiles_ref:refs/heads/master"
]
}
[03:45:38.469] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1554263137420841",
"id": "8917230692374934688",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"492b866a2776db106c6205fa1668412f48d4bf9b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554263138054267",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12690",
"builder:Windows deterministic",
"buildset:commit/git/492b866a2776db106c6205fa1668412f48d4bf9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/492b866a2776db106c6205fa1668412f48d4bf9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082660754369469104",
"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/8917230692374934688/+/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": "1554263138054402",
"url": "https://ci.chromium.org/b/8917230692374934688",
"utcnow_ts": "1554263138456261"
}
}
[03:45:38.469] Task URL: https://ci.chromium.org/b/8917230692374934688
[03:45:38.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:2:0) after 1m0s
[03:45:41.724] Received PubSub notification, asking Buildbucket for the build status
[03:45:41.891] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:38.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:2:0)
[03:46:38.488] Timer tick, asking Buildbucket for the build status
[03:46:38.605] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:38.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:4:0) after 1m0s
[03:47:38.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:4:0)
[03:47:38.614] Timer tick, asking Buildbucket for the build status
[03:47:38.811] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:38.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:5:0) after 1m0s
[03:48:38.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:5:0)
[03:48:38.831] Timer tick, asking Buildbucket for the build status
[03:48:38.944] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:38.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:6:0) after 1m0s
[03:49:38.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:6:0)
[03:49:38.922] Timer tick, asking Buildbucket for the build status
[03:49:39.016] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:39.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:7:0) after 1m0s
[03:50:39.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:7:0)
[03:50:39.054] Timer tick, asking Buildbucket for the build status
[03:50:39.579] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:39.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:8:0) after 1m0s
[03:51:39.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:8:0)
[03:51:39.581] Timer tick, asking Buildbucket for the build status
[03:51:39.719] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:39.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:9:0) after 1m0s
[03:52:39.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:9:0)
[03:52:39.694] Timer tick, asking Buildbucket for the build status
[03:52:39.996] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:39.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:10:0) after 1m0s
[03:53:40.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:10:0)
[03:53:40.017] Timer tick, asking Buildbucket for the build status
[03:53:40.161] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:40.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:11:0) after 1m0s
[03:54:40.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:11:0)
[03:54:40.207] Timer tick, asking Buildbucket for the build status
[03:54:40.431] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:40.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:12:0) after 1m0s
[03:55:40.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:12:0)
[03:55:40.421] Timer tick, asking Buildbucket for the build status
[03:55:40.518] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:40.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:13:0) after 1m0s
[03:56:40.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:13:0)
[03:56:40.536] Timer tick, asking Buildbucket for the build status
[03:56:40.770] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:40.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:14:0) after 1m0s
[03:57:40.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:14:0)
[03:57:40.790] Timer tick, asking Buildbucket for the build status
[03:57:40.942] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:40.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:15:0) after 1m0s
[03:58:40.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:15:0)
[03:58:40.963] Timer tick, asking Buildbucket for the build status
[03:58:41.612] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:41.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:16:0) after 1m0s
[03:59:41.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:16:0)
[03:59:41.648] Timer tick, asking Buildbucket for the build status
[03:59:42.102] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:42.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:17:0) after 1m0s
[04:00:42.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:17:0)
[04:00:42.124] Timer tick, asking Buildbucket for the build status
[04:00:42.461] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:42.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:18:0) after 1m0s
[04:01:42.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:18:0)
[04:01:42.482] Timer tick, asking Buildbucket for the build status
[04:01:43.270] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:43.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:19:0) after 1m0s
[04:02:43.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:19:0)
[04:02:43.284] Timer tick, asking Buildbucket for the build status
[04:02:43.428] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:43.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:20:0) after 1m0s
[04:03:43.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:20:0)
[04:03:43.446] Timer tick, asking Buildbucket for the build status
[04:03:43.587] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:43.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:21:0) after 1m0s
[04:04:43.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:21:0)
[04:04:43.576] Timer tick, asking Buildbucket for the build status
[04:04:43.873] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:43.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:22:0) after 1m0s
[04:05:43.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:22:0)
[04:05:43.879] Timer tick, asking Buildbucket for the build status
[04:05:44.372] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:44.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:23:0) after 1m0s
[04:06:44.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:23:0)
[04:06:44.371] Timer tick, asking Buildbucket for the build status
[04:06:44.595] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:44.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:24:0) after 1m0s
[04:07:44.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:24:0)
[04:07:44.597] Timer tick, asking Buildbucket for the build status
[04:07:45.482] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:45.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:25:0) after 1m0s
[04:08:45.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:25:0)
[04:08:45.479] Timer tick, asking Buildbucket for the build status
[04:08:45.807] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:26:0) after 1m0s
[04:09:45.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:26:0)
[04:09:45.826] Timer tick, asking Buildbucket for the build status
[04:09:46.102] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:46.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:27:0) after 1m0s
[04:10:46.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:27:0)
[04:10:46.125] Timer tick, asking Buildbucket for the build status
[04:10:46.777] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:46.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:28:0) after 1m0s
[04:11:46.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:28:0)
[04:11:46.769] Timer tick, asking Buildbucket for the build status
[04:11:47.010] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:47.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:29:0) after 1m0s
[04:12:46.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:29:0)
[04:12:46.990] Timer tick, asking Buildbucket for the build status
[04:12:47.891] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:30:0) after 1m0s
[04:13:47.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:30:0)
[04:13:47.904] Timer tick, asking Buildbucket for the build status
[04:13:48.092] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:48.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:31:0) after 1m0s
[04:14:48.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:31:0)
[04:14:48.113] Timer tick, asking Buildbucket for the build status
[04:14:48.196] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:48.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:32:0) after 1m0s
[04:15:48.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:32:0)
[04:15:48.218] Timer tick, asking Buildbucket for the build status
[04:15:49.276] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:49.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:33:0) after 1m0s
[04:16:49.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:33:0)
[04:16:49.316] Timer tick, asking Buildbucket for the build status
[04:16:49.507] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:49.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:34:0) after 1m0s
[04:17:49.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:34:0)
[04:17:49.535] Timer tick, asking Buildbucket for the build status
[04:17:49.898] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:49.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:35:0) after 1m0s
[04:18:49.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:35:0)
[04:18:49.913] Timer tick, asking Buildbucket for the build status
[04:18:49.995] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:49.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:36:0) after 1m0s
[04:19:54.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:36:0)
[04:19:54.945] Timer tick, asking Buildbucket for the build status
[04:19:55.364] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:55.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:37:0) after 1m0s
[04:20:55.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:37:0)
[04:20:55.347] Timer tick, asking Buildbucket for the build status
[04:20:56.411] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:56.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:38:0) after 1m0s
[04:21:56.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:38:0)
[04:21:56.421] Timer tick, asking Buildbucket for the build status
[04:21:56.592] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:56.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:39:0) after 1m0s
[04:22:56.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:39:0)
[04:22:56.572] Timer tick, asking Buildbucket for the build status
[04:22:56.764] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:56.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:40:0) after 1m0s
[04:23:56.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:40:0)
[04:23:56.809] Timer tick, asking Buildbucket for the build status
[04:23:57.671] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:57.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:41:0) after 1m0s
[04:24:57.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:41:0)
[04:24:57.701] Timer tick, asking Buildbucket for the build status
[04:24:58.616] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:58.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:42:0) after 1m0s
[04:25:58.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:42:0)
[04:25:58.605] Timer tick, asking Buildbucket for the build status
[04:25:58.719] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:58.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:43:0) after 1m0s
[04:26:58.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:43:0)
[04:26:58.694] Timer tick, asking Buildbucket for the build status
[04:26:59.172] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:59.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:44:0) after 1m0s
[04:27:59.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:44:0)
[04:27:59.216] Timer tick, asking Buildbucket for the build status
[04:27:59.620] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:59.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:45:0) after 1m0s
[04:28:59.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:45:0)
[04:28:59.769] Timer tick, asking Buildbucket for the build status
[04:28:59.874] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:59.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:46:0) after 1m0s
[04:29:59.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:46:0)
[04:29:59.887] Timer tick, asking Buildbucket for the build status
[04:30:00.135] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:00.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:47:0) after 1m0s
[04:31:00.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:47:0)
[04:31:00.175] Timer tick, asking Buildbucket for the build status
[04:31:00.265] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:48:0) after 1m0s
[04:32:04.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:48:0)
[04:32:04.962] Timer tick, asking Buildbucket for the build status
[04:32:05.148] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:05.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:49:0) after 1m0s
[04:33:05.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:49:0)
[04:33:05.160] Timer tick, asking Buildbucket for the build status
[04:33:05.267] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:05.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:50:0) after 1m0s
[04:34:05.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:50:0)
[04:34:05.310] Timer tick, asking Buildbucket for the build status
[04:34:05.791] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:05.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:51:0) after 1m0s
[04:35:05.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:51:0)
[04:35:05.827] Timer tick, asking Buildbucket for the build status
[04:35:06.476] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:06.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:52:0) after 1m0s
[04:36:06.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:52:0)
[04:36:06.485] Timer tick, asking Buildbucket for the build status
[04:36:06.602] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:06.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:53:0) after 1m0s
[04:37:06.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:53:0)
[04:37:06.625] Timer tick, asking Buildbucket for the build status
[04:37:06.813] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:06.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:54:0) after 1m0s
[04:38:06.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:54:0)
[04:38:06.820] Timer tick, asking Buildbucket for the build status
[04:38:07.273] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:07.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:55:0) after 1m0s
[04:39:07.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:55:0)
[04:39:07.371] Timer tick, asking Buildbucket for the build status
[04:39:07.579] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:07.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:56:0) after 1m0s
[04:40:07.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:56:0)
[04:40:07.593] Timer tick, asking Buildbucket for the build status
[04:40:07.720] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:07.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:57:0) after 1m0s
[04:41:07.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:57:0)
[04:41:07.764] Timer tick, asking Buildbucket for the build status
[04:41:07.851] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:07.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:58:0) after 1m0s
[04:42:07.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:58:0)
[04:42:07.869] Timer tick, asking Buildbucket for the build status
[04:42:08.193] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:08.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:59:0) after 1m0s
[04:43:08.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:59:0)
[04:43:08.222] Timer tick, asking Buildbucket for the build status
[04:43:08.503] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:08.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:60:0) after 1m0s
[04:44:08.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:60:0)
[04:44:08.521] Timer tick, asking Buildbucket for the build status
[04:44:08.618] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:08.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:61:0) after 1m0s
[04:45:08.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:61:0)
[04:45:08.649] Timer tick, asking Buildbucket for the build status
[04:45:08.974] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:08.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:62:0) after 1m0s
[04:46:08.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:62:0)
[04:46:08.966] Timer tick, asking Buildbucket for the build status
[04:46:09.664] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:09.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:63:0) after 1m0s
[04:47:09.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:63:0)
[04:47:09.689] Timer tick, asking Buildbucket for the build status
[04:47:10.871] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:10.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:64:0) after 1m0s
[04:48:10.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:64:0)
[04:48:10.885] Timer tick, asking Buildbucket for the build status
[04:48:10.964] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:10.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:65:0) after 1m0s
[04:49:10.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:65:0)
[04:49:10.959] Timer tick, asking Buildbucket for the build status
[04:49:11.099] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:11.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:66:0) after 1m0s
[04:50:11.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:66:0)
[04:50:11.085] Timer tick, asking Buildbucket for the build status
[04:50:11.406] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:11.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:67:0) after 1m0s
[04:51:11.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:67:0)
[04:51:11.429] Timer tick, asking Buildbucket for the build status
[04:51:11.573] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:11.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:68:0) after 1m0s
[04:52:11.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:68:0)
[04:52:11.595] Timer tick, asking Buildbucket for the build status
[04:52:11.765] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:11.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:69:0) after 1m0s
[04:53:11.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:69:0)
[04:53:11.789] Timer tick, asking Buildbucket for the build status
[04:53:11.891] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:11.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:70:0) after 1m0s
[04:54:11.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:70:0)
[04:54:11.867] Timer tick, asking Buildbucket for the build status
[04:54:12.164] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:71:0) after 1m0s
[04:55:12.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:71:0)
[04:55:12.186] Timer tick, asking Buildbucket for the build status
[04:55:12.688] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:12.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:72:0) after 1m0s
[04:56:12.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:72:0)
[04:56:12.714] Timer tick, asking Buildbucket for the build status
[04:56:12.829] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:12.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:73:0) after 1m0s
[04:57:12.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:73:0)
[04:57:12.854] Timer tick, asking Buildbucket for the build status
[04:57:12.972] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:12.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:74:0) after 1m0s
[04:58:13.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:74:0)
[04:58:13.014] Timer tick, asking Buildbucket for the build status
[04:58:13.117] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:13.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:75:0) after 1m0s
[04:59:13.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:75:0)
[04:59:13.112] Timer tick, asking Buildbucket for the build status
[04:59:13.391] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:13.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:76:0) after 1m0s
[05:00:13.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:76:0)
[05:00:13.371] Timer tick, asking Buildbucket for the build status
[05:00:13.551] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:13.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:77:0) after 1m0s
[05:01:13.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:77:0)
[05:01:13.567] Timer tick, asking Buildbucket for the build status
[05:01:13.797] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:13.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:78:0) after 1m0s
[05:02:13.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:78:0)
[05:02:13.793] Timer tick, asking Buildbucket for the build status
[05:02:14.170] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:14.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:79:0) after 1m0s
[05:03:14.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:79:0)
[05:03:14.209] Timer tick, asking Buildbucket for the build status
[05:03:14.756] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:14.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:80:0) after 1m0s
[05:04:14.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:80:0)
[05:04:14.814] Timer tick, asking Buildbucket for the build status
[05:04:14.899] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:14.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:81:0) after 1m0s
[05:05:14.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:81:0)
[05:05:14.892] Timer tick, asking Buildbucket for the build status
[05:05:15.082] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:15.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:82:0) after 1m0s
[05:06:15.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:82:0)
[05:06:15.124] Timer tick, asking Buildbucket for the build status
[05:06:15.235] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:15.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:83:0) after 1m0s
[05:07:15.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:83:0)
[05:07:15.256] Timer tick, asking Buildbucket for the build status
[05:07:15.880] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:15.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:84:0) after 1m0s
[05:08:15.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:84:0)
[05:08:15.877] Timer tick, asking Buildbucket for the build status
[05:08:16.044] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:16.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:85:0) after 1m0s
[05:09:16.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:85:0)
[05:09:16.038] Timer tick, asking Buildbucket for the build status
[05:09:16.392] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:16.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:86:0) after 1m0s
[05:10:16.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:86:0)
[05:10:16.415] Timer tick, asking Buildbucket for the build status
[05:10:16.522] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:16.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:87:0) after 1m0s
[05:11:16.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:87:0)
[05:11:16.550] Timer tick, asking Buildbucket for the build status
[05:11:16.826] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:16.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:88:0) after 1m0s
[05:12:16.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:88:0)
[05:12:16.848] Timer tick, asking Buildbucket for the build status
[05:12:17.364] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:17.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:89:0) after 1m0s
[05:13:17.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:89:0)
[05:13:17.372] Timer tick, asking Buildbucket for the build status
[05:13:18.353] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:90:0) after 1m0s
[05:14:18.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:90:0)
[05:14:18.335] Timer tick, asking Buildbucket for the build status
[05:14:18.491] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:18.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:91:0) after 1m0s
[05:15:18.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:91:0)
[05:15:18.512] Timer tick, asking Buildbucket for the build status
[05:15:19.088] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:19.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:92:0) after 1m0s
[05:16:19.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:92:0)
[05:16:19.124] Timer tick, asking Buildbucket for the build status
[05:16:19.672] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:19.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:93:0) after 1m0s
[05:17:19.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:93:0)
[05:17:19.702] Timer tick, asking Buildbucket for the build status
[05:17:19.901] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:19.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:94:0) after 1m0s
[05:18:19.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:94:0)
[05:18:19.926] Timer tick, asking Buildbucket for the build status
[05:18:20.033] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:20.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:95:0) after 1m0s
[05:19:20.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:95:0)
[05:19:20.057] Timer tick, asking Buildbucket for the build status
[05:19:20.154] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:96:0) after 1m0s
[05:20:20.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:96:0)
[05:20:20.197] Timer tick, asking Buildbucket for the build status
[05:20:20.501] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:20.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:97:0) after 1m0s
[05:21:20.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:97:0)
[05:21:20.522] Timer tick, asking Buildbucket for the build status
[05:21:20.725] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:20.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:98:0) after 1m0s
[05:22:20.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:98:0)
[05:22:20.711] Timer tick, asking Buildbucket for the build status
[05:22:20.990] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:20.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:99:0) after 1m0s
[05:23:20.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:99:0)
[05:23:20.974] Timer tick, asking Buildbucket for the build status
[05:23:21.323] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:100:0) after 1m0s
[05:24:21.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:100:0)
[05:24:21.339] Timer tick, asking Buildbucket for the build status
[05:24:21.446] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:101:0) after 1m0s
[05:25:21.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:101:0)
[05:25:21.424] Timer tick, asking Buildbucket for the build status
[05:25:21.857] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:21.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:102:0) after 1m0s
[05:26:21.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:102:0)
[05:26:21.880] Timer tick, asking Buildbucket for the build status
[05:26:22.167] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:22.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:103:0) after 1m0s
[05:27:22.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:103:0)
[05:27:22.204] Timer tick, asking Buildbucket for the build status
[05:27:22.330] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:22.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:104:0) after 1m0s
[05:28:22.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:104:0)
[05:28:22.370] Timer tick, asking Buildbucket for the build status
[05:28:22.500] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:22.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:105:0) after 1m0s
[05:29:22.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:105:0)
[05:29:22.523] Timer tick, asking Buildbucket for the build status
[05:29:22.672] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:22.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:106:0) after 1m0s
[05:30:22.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:106:0)
[05:30:22.691] Timer tick, asking Buildbucket for the build status
[05:30:22.802] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:22.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:107:0) after 1m0s
[05:31:22.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:107:0)
[05:31:22.830] Timer tick, asking Buildbucket for the build status
[05:31:23.781] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:23.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:108:0) after 1m0s
[05:32:23.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:108:0)
[05:32:23.783] Timer tick, asking Buildbucket for the build status
[05:32:23.874] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:23.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:109:0) after 1m0s
[05:33:23.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:109:0)
[05:33:23.897] Timer tick, asking Buildbucket for the build status
[05:33:23.993] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:23.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:110:0) after 1m0s
[05:34:24.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:110:0)
[05:34:24.027] Timer tick, asking Buildbucket for the build status
[05:34:24.130] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:24.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:111:0) after 1m0s
[05:35:24.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:111:0)
[05:35:24.153] Timer tick, asking Buildbucket for the build status
[05:35:24.855] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:24.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:112:0) after 1m0s
[05:36:24.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:112:0)
[05:36:24.894] Timer tick, asking Buildbucket for the build status
[05:36:25.560] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:25.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:113:0) after 1m0s
[05:37:25.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:113:0)
[05:37:25.583] Timer tick, asking Buildbucket for the build status
[05:37:25.830] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:25.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:114:0) after 1m0s
[05:38:25.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:114:0)
[05:38:25.857] Timer tick, asking Buildbucket for the build status
[05:38:26.007] Build 8917230692374934688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:26.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9082660754369469104:115:0) after 1m0s
[05:39:18.859] Received PubSub notification, asking Buildbucket for the build status
[05:39:18.967] Build 8917230692374934688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:39:18.967] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1554269957824371",
"created_by": "project:chromium",
"created_ts": "1554263137420841",
"id": "8917230692374934688",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"492b866a2776db106c6205fa1668412f48d4bf9b\"}}",
"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-93fj\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 12690, \"got_angle_revision\": \"2889dff6991a710c52f8d8fdae567f107e5d2c1d\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"492b866a2776db106c6205fa1668412f48d4bf9b\", \"got_revision_cp\": \"refs/heads/master@{#647131}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"c0843ced0895d1a1415bdd39650994ba574ff5a3\", \"got_v8_revision_cp\": \"refs/heads/7.5.168@{#1}\", \"got_webrtc_revision\": \"d98cbd8f91a3d94c08e3154ec78c2e54dbd3564e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27421}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"492b866a2776db106c6205fa1668412f48d4bf9b\"}, \"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-93fj\"], \"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\": [\"4237-a5bdaf4\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554263141045856",
"status": "COMPLETED",
"status_changed_ts": "1554269958563589",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12690",
"builder:Windows deterministic",
"buildset:commit/git/492b866a2776db106c6205fa1668412f48d4bf9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/492b866a2776db106c6205fa1668412f48d4bf9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082660754369469104",
"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/8917230692374934688/+/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:43fa1ee90111e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1554269958567186",
"url": "https://ci.chromium.org/b/8917230692374934688",
"utcnow_ts": "1554269958958346"
}
}
[05:39:18.967] Invocation finished in 1h53m42.83249177s with status SUCCEEDED