[14:01:56.958] New invocation is queued and will start shortly
[14:01:58.143] Starting the invocation (attempt 1)
[14:01:58.185] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:01:58.185] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:01:58.185] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059972735588362144",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eb726b5012a177d901a44356f25fa6b1f9172f3d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9059972735588362144",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"gitiles_ref:refs/heads/master"
]
}
[14:02:00.105] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575900118652143",
"id": "8894542673142692224",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb726b5012a177d901a44356f25fa6b1f9172f3d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575900119846820",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15416",
"builder:Windows deterministic",
"buildset:commit/git/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059972735588362144",
"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/8894542673142692224/+/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": "1575900119846920",
"url": "https://ci.chromium.org/b/8894542673142692224",
"utcnow_ts": "1575900120059931"
}
}
[14:02:00.105] Task URL: https://ci.chromium.org/b/8894542673142692224
[14:02:00.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:2:0) after 1m0s
[14:02:05.584] Received PubSub notification, asking Buildbucket for the build status
[14:02:06.067] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:00.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:2:0)
[14:03:00.157] Timer tick, asking Buildbucket for the build status
[14:03:00.586] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:00.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:4:0) after 1m0s
[14:04:01.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:4:0)
[14:04:01.772] Timer tick, asking Buildbucket for the build status
[14:04:02.598] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:02.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:5:0) after 1m0s
[14:05:02.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:5:0)
[14:05:02.626] Timer tick, asking Buildbucket for the build status
[14:05:03.493] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:6:0) after 1m0s
[14:06:03.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:6:0)
[14:06:03.584] Timer tick, asking Buildbucket for the build status
[14:06:03.733] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:03.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:7:0) after 1m0s
[14:07:03.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:7:0)
[14:07:03.803] Timer tick, asking Buildbucket for the build status
[14:07:03.978] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:03.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:8:0) after 1m0s
[14:08:03.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:8:0)
[14:08:03.995] Timer tick, asking Buildbucket for the build status
[14:08:04.314] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:04.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:9:0) after 1m0s
[14:09:04.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:9:0)
[14:09:04.441] Timer tick, asking Buildbucket for the build status
[14:09:04.630] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:04.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:10:0) after 1m0s
[14:10:04.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:10:0)
[14:10:04.711] Timer tick, asking Buildbucket for the build status
[14:10:05.414] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:05.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:11:0) after 1m0s
[14:11:05.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:11:0)
[14:11:05.489] Timer tick, asking Buildbucket for the build status
[14:11:06.507] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:12:0) after 1m0s
[14:12:06.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:12:0)
[14:12:06.498] Timer tick, asking Buildbucket for the build status
[14:12:06.972] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:13:0) after 1m0s
[14:13:07.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:13:0)
[14:13:07.102] Timer tick, asking Buildbucket for the build status
[14:13:07.268] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:07.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:14:0) after 1m0s
[14:14:07.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:14:0)
[14:14:07.452] Timer tick, asking Buildbucket for the build status
[14:14:07.655] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:07.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:15:0) after 1m0s
[14:15:07.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:15:0)
[14:15:07.838] Timer tick, asking Buildbucket for the build status
[14:15:08.033] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:16:0) after 1m0s
[14:16:08.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:16:0)
[14:16:08.744] Timer tick, asking Buildbucket for the build status
[14:16:09.134] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:09.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:17:0) after 1m0s
[14:17:10.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:17:0)
[14:17:10.678] Timer tick, asking Buildbucket for the build status
[14:17:11.654] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:11.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:18:0) after 1m0s
[14:18:11.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:18:0)
[14:18:11.829] Timer tick, asking Buildbucket for the build status
[14:18:12.101] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:19:0) after 1m0s
[14:19:12.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:19:0)
[14:19:12.284] Timer tick, asking Buildbucket for the build status
[14:19:13.090] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:13.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:20:0) after 1m0s
[14:20:13.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:20:0)
[14:20:13.188] Timer tick, asking Buildbucket for the build status
[14:20:15.584] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:15.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:21:0) after 1m0s
[14:21:15.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:21:0)
[14:21:15.730] Timer tick, asking Buildbucket for the build status
[14:21:16.341] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:22:0) after 1m0s
[14:22:16.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:22:0)
[14:22:16.466] Timer tick, asking Buildbucket for the build status
[14:22:16.995] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:23:0) after 1m0s
[14:23:17.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:23:0)
[14:23:17.092] Timer tick, asking Buildbucket for the build status
[14:23:17.381] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:17.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:24:0) after 1m0s
[14:24:17.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:24:0)
[14:24:17.436] Timer tick, asking Buildbucket for the build status
[14:24:17.706] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:17.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:25:0) after 1m0s
[14:25:17.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:25:0)
[14:25:17.726] Timer tick, asking Buildbucket for the build status
[14:25:18.527] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:18.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:26:0) after 1m0s
[14:26:18.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:26:0)
[14:26:18.618] Timer tick, asking Buildbucket for the build status
[14:26:18.827] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:18.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:27:0) after 1m0s
[14:27:18.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:27:0)
[14:27:18.850] Timer tick, asking Buildbucket for the build status
[14:27:19.374] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:19.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:28:0) after 1m0s
[14:28:19.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:28:0)
[14:28:19.529] Timer tick, asking Buildbucket for the build status
[14:28:19.821] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:19.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:29:0) after 1m0s
[14:29:19.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:29:0)
[14:29:19.888] Timer tick, asking Buildbucket for the build status
[14:29:20.151] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:20.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:30:0) after 1m0s
[14:30:20.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:30:0)
[14:30:20.191] Timer tick, asking Buildbucket for the build status
[14:30:20.537] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:20.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:31:0) after 1m0s
[14:31:20.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:31:0)
[14:31:20.602] Timer tick, asking Buildbucket for the build status
[14:31:21.014] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:21.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:32:0) after 1m0s
[14:32:21.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:32:0)
[14:32:21.185] Timer tick, asking Buildbucket for the build status
[14:32:21.388] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:21.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:33:0) after 1m0s
[14:33:21.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:33:0)
[14:33:21.629] Timer tick, asking Buildbucket for the build status
[14:33:21.760] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:21.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:34:0) after 1m0s
[14:34:21.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:34:0)
[14:34:21.880] Timer tick, asking Buildbucket for the build status
[14:34:22.081] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:22.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:35:0) after 1m0s
[14:35:22.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:35:0)
[14:35:22.542] Timer tick, asking Buildbucket for the build status
[14:35:23.135] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:23.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:36:0) after 1m0s
[14:36:23.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:36:0)
[14:36:23.337] Timer tick, asking Buildbucket for the build status
[14:36:24.322] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:24.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:37:0) after 1m0s
[14:37:24.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:37:0)
[14:37:24.439] Timer tick, asking Buildbucket for the build status
[14:37:25.031] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:25.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:38:0) after 1m0s
[14:38:25.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:38:0)
[14:38:25.112] Timer tick, asking Buildbucket for the build status
[14:38:26.064] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:26.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:39:0) after 1m0s
[14:39:26.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:39:0)
[14:39:26.155] Timer tick, asking Buildbucket for the build status
[14:39:26.363] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:26.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:40:0) after 1m0s
[14:40:26.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:40:0)
[14:40:26.623] Timer tick, asking Buildbucket for the build status
[14:40:27.246] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:27.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:41:0) after 1m0s
[14:41:27.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:41:0)
[14:41:27.819] Timer tick, asking Buildbucket for the build status
[14:41:28.672] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:28.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:42:0) after 1m0s
[14:42:29.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:42:0)
[14:42:29.924] Timer tick, asking Buildbucket for the build status
[14:42:30.152] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:30.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:43:0) after 1m0s
[14:43:30.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:43:0)
[14:43:30.230] Timer tick, asking Buildbucket for the build status
[14:43:30.460] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:30.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:44:0) after 1m0s
[14:44:30.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:44:0)
[14:44:30.544] Timer tick, asking Buildbucket for the build status
[14:44:33.770] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:33.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:45:0) after 1m0s
[14:45:33.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:45:0)
[14:45:33.840] Timer tick, asking Buildbucket for the build status
[14:45:34.191] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:34.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:46:0) after 1m0s
[14:46:34.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:46:0)
[14:46:34.238] Timer tick, asking Buildbucket for the build status
[14:46:35.146] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:35.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:47:0) after 1m0s
[14:47:35.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:47:0)
[14:47:35.179] Timer tick, asking Buildbucket for the build status
[14:47:35.678] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:35.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:48:0) after 1m0s
[14:48:35.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:48:0)
[14:48:35.661] Timer tick, asking Buildbucket for the build status
[14:48:36.038] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:36.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:49:0) after 1m0s
[14:49:36.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:49:0)
[14:49:36.189] Timer tick, asking Buildbucket for the build status
[14:49:37.054] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:37.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:50:0) after 1m0s
[14:50:37.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:50:0)
[14:50:37.127] Timer tick, asking Buildbucket for the build status
[14:50:37.443] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:37.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:51:0) after 1m0s
[14:51:37.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:51:0)
[14:51:37.496] Timer tick, asking Buildbucket for the build status
[14:51:38.603] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:38.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:52:0) after 1m0s
[14:52:38.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:52:0)
[14:52:38.636] Timer tick, asking Buildbucket for the build status
[14:52:38.981] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:38.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:53:0) after 1m0s
[14:53:39.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:53:0)
[14:53:39.003] Timer tick, asking Buildbucket for the build status
[14:53:39.443] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:39.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:54:0) after 1m0s
[14:54:39.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:54:0)
[14:54:39.552] Timer tick, asking Buildbucket for the build status
[14:54:39.820] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:39.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:55:0) after 1m0s
[14:55:39.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:55:0)
[14:55:39.869] Timer tick, asking Buildbucket for the build status
[14:55:40.384] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:40.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:56:0) after 1m0s
[14:56:40.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:56:0)
[14:56:40.447] Timer tick, asking Buildbucket for the build status
[14:56:40.687] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:40.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:57:0) after 1m0s
[14:57:40.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:57:0)
[14:57:40.867] Timer tick, asking Buildbucket for the build status
[14:57:41.260] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:58:0) after 1m0s
[14:58:41.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:58:0)
[14:58:41.658] Timer tick, asking Buildbucket for the build status
[14:58:43.888] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:43.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:59:0) after 1m0s
[14:59:44.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:59:0)
[14:59:44.239] Timer tick, asking Buildbucket for the build status
[14:59:45.015] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:45.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:60:0) after 1m0s
[15:00:45.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:60:0)
[15:00:45.102] Timer tick, asking Buildbucket for the build status
[15:00:45.398] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:45.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:61:0) after 1m0s
[15:01:45.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:61:0)
[15:01:45.465] Timer tick, asking Buildbucket for the build status
[15:01:45.911] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:45.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:62:0) after 1m0s
[15:02:45.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:62:0)
[15:02:45.942] Timer tick, asking Buildbucket for the build status
[15:02:46.344] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:46.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:63:0) after 1m0s
[15:03:46.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:63:0)
[15:03:46.413] Timer tick, asking Buildbucket for the build status
[15:03:46.764] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:46.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:64:0) after 1m0s
[15:04:46.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:64:0)
[15:04:46.766] Timer tick, asking Buildbucket for the build status
[15:04:47.184] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:47.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:65:0) after 1m0s
[15:05:47.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:65:0)
[15:05:47.336] Timer tick, asking Buildbucket for the build status
[15:05:47.485] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:47.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:66:0) after 1m0s
[15:06:47.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:66:0)
[15:06:47.615] Timer tick, asking Buildbucket for the build status
[15:06:47.964] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:47.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:67:0) after 1m0s
[15:07:48.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:67:0)
[15:07:48.028] Timer tick, asking Buildbucket for the build status
[15:07:48.596] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:48.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:68:0) after 1m0s
[15:08:48.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:68:0)
[15:08:48.637] Timer tick, asking Buildbucket for the build status
[15:08:49.535] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:49.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:69:0) after 1m0s
[15:09:49.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:69:0)
[15:09:49.596] Timer tick, asking Buildbucket for the build status
[15:09:49.960] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:49.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:70:0) after 1m0s
[15:10:50.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:70:0)
[15:10:50.063] Timer tick, asking Buildbucket for the build status
[15:10:51.009] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:51.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:71:0) after 1m0s
[15:11:51.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:71:0)
[15:11:51.095] Timer tick, asking Buildbucket for the build status
[15:11:51.952] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:51.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:72:0) after 1m0s
[15:12:52.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:72:0)
[15:12:52.012] Timer tick, asking Buildbucket for the build status
[15:12:52.473] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:52.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:73:0) after 1m0s
[15:13:52.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:73:0)
[15:13:52.513] Timer tick, asking Buildbucket for the build status
[15:13:53.124] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:53.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:74:0) after 1m0s
[15:14:53.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:74:0)
[15:14:53.172] Timer tick, asking Buildbucket for the build status
[15:14:54.240] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:54.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:75:0) after 1m0s
[15:15:54.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:75:0)
[15:15:54.333] Timer tick, asking Buildbucket for the build status
[15:15:54.500] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:54.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:76:0) after 1m0s
[15:16:54.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:76:0)
[15:16:54.527] Timer tick, asking Buildbucket for the build status
[15:16:54.756] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:54.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:77:0) after 1m0s
[15:17:54.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:77:0)
[15:17:54.792] Timer tick, asking Buildbucket for the build status
[15:17:54.946] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:54.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:78:0) after 1m0s
[15:18:54.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:78:0)
[15:18:54.978] Timer tick, asking Buildbucket for the build status
[15:18:55.509] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:55.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:79:0) after 1m0s
[15:19:56.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:79:0)
[15:19:56.194] Timer tick, asking Buildbucket for the build status
[15:19:57.464] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:57.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:80:0) after 1m0s
[15:20:58.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:80:0)
[15:20:58.830] Timer tick, asking Buildbucket for the build status
[15:20:59.169] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:59.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:81:0) after 1m0s
[15:21:59.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:81:0)
[15:21:59.182] Timer tick, asking Buildbucket for the build status
[15:21:59.496] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:59.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:82:0) after 1m0s
[15:22:59.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:82:0)
[15:22:59.524] Timer tick, asking Buildbucket for the build status
[15:23:01.519] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:01.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:83:0) after 1m0s
[15:24:02.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:83:0)
[15:24:02.251] Timer tick, asking Buildbucket for the build status
[15:24:02.542] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:02.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:84:0) after 1m0s
[15:25:02.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:84:0)
[15:25:02.828] Timer tick, asking Buildbucket for the build status
[15:25:03.884] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:03.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:85:0) after 1m0s
[15:26:03.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:85:0)
[15:26:03.911] Timer tick, asking Buildbucket for the build status
[15:26:04.217] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:04.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:86:0) after 1m0s
[15:27:04.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:86:0)
[15:27:04.375] Timer tick, asking Buildbucket for the build status
[15:27:04.806] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:04.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:87:0) after 1m0s
[15:28:04.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:87:0)
[15:28:04.884] Timer tick, asking Buildbucket for the build status
[15:28:06.445] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:06.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:88:0) after 1m0s
[15:29:06.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:88:0)
[15:29:06.637] Timer tick, asking Buildbucket for the build status
[15:29:07.133] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:07.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:89:0) after 1m0s
[15:30:07.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:89:0)
[15:30:07.311] Timer tick, asking Buildbucket for the build status
[15:30:07.761] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:07.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:90:0) after 1m0s
[15:31:07.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:90:0)
[15:31:07.815] Timer tick, asking Buildbucket for the build status
[15:31:08.241] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:08.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:91:0) after 1m0s
[15:32:08.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:91:0)
[15:32:08.224] Timer tick, asking Buildbucket for the build status
[15:32:08.670] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:08.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:92:0) after 1m0s
[15:33:08.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:92:0)
[15:33:08.904] Timer tick, asking Buildbucket for the build status
[15:33:09.388] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:09.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:93:0) after 1m0s
[15:34:09.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:93:0)
[15:34:09.538] Timer tick, asking Buildbucket for the build status
[15:34:09.720] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:09.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:94:0) after 1m0s
[15:35:09.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:94:0)
[15:35:09.804] Timer tick, asking Buildbucket for the build status
[15:35:10.522] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:10.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:95:0) after 1m0s
[15:36:10.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:95:0)
[15:36:10.620] Timer tick, asking Buildbucket for the build status
[15:36:10.872] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:10.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:96:0) after 1m0s
[15:37:11.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:96:0)
[15:37:11.437] Timer tick, asking Buildbucket for the build status
[15:37:11.752] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:11.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:97:0) after 1m0s
[15:38:12.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:97:0)
[15:38:12.072] Timer tick, asking Buildbucket for the build status
[15:38:12.301] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:12.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:98:0) after 1m0s
[15:39:12.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:98:0)
[15:39:12.704] Timer tick, asking Buildbucket for the build status
[15:39:12.915] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:12.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:99:0) after 1m0s
[15:40:13.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:99:0)
[15:40:13.074] Timer tick, asking Buildbucket for the build status
[15:40:13.327] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:13.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:100:0) after 1m0s
[15:41:13.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:100:0)
[15:41:13.374] Timer tick, asking Buildbucket for the build status
[15:41:13.887] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:13.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:101:0) after 1m0s
[15:42:13.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:101:0)
[15:42:13.945] Timer tick, asking Buildbucket for the build status
[15:42:14.251] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:14.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:102:0) after 1m0s
[15:43:14.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:102:0)
[15:43:14.308] Timer tick, asking Buildbucket for the build status
[15:43:14.740] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:14.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:103:0) after 1m0s
[15:44:14.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:103:0)
[15:44:14.896] Timer tick, asking Buildbucket for the build status
[15:44:15.354] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:15.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:104:0) after 1m0s
[15:45:15.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:104:0)
[15:45:15.516] Timer tick, asking Buildbucket for the build status
[15:45:16.782] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:16.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:105:0) after 1m0s
[15:46:16.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:105:0)
[15:46:16.834] Timer tick, asking Buildbucket for the build status
[15:46:17.237] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:17.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:106:0) after 1m0s
[15:47:17.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:106:0)
[15:47:17.378] Timer tick, asking Buildbucket for the build status
[15:47:18.381] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:18.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:107:0) after 1m0s
[15:48:18.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:107:0)
[15:48:18.468] Timer tick, asking Buildbucket for the build status
[15:48:18.753] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:18.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:108:0) after 1m0s
[15:49:18.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:108:0)
[15:49:18.797] Timer tick, asking Buildbucket for the build status
[15:49:20.147] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:20.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:109:0) after 1m0s
[15:50:20.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:109:0)
[15:50:20.274] Timer tick, asking Buildbucket for the build status
[15:50:21.147] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:21.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:110:0) after 1m0s
[15:51:21.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:110:0)
[15:51:21.219] Timer tick, asking Buildbucket for the build status
[15:51:21.503] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:21.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:111:0) after 1m0s
[15:52:21.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:111:0)
[15:52:21.536] Timer tick, asking Buildbucket for the build status
[15:52:23.358] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:23.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:112:0) after 1m0s
[15:53:23.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:112:0)
[15:53:23.426] Timer tick, asking Buildbucket for the build status
[15:53:23.916] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:23.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:113:0) after 1m0s
[15:54:23.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:113:0)
[15:54:23.964] Timer tick, asking Buildbucket for the build status
[15:54:24.413] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:24.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:114:0) after 1m0s
[15:55:24.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:114:0)
[15:55:24.432] Timer tick, asking Buildbucket for the build status
[15:55:24.672] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:24.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:115:0) after 1m0s
[15:56:24.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:115:0)
[15:56:24.773] Timer tick, asking Buildbucket for the build status
[15:56:25.104] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:116:0) after 1m0s
[15:57:25.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:116:0)
[15:57:25.177] Timer tick, asking Buildbucket for the build status
[15:57:25.384] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:25.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:117:0) after 1m0s
[15:58:25.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:117:0)
[15:58:25.507] Timer tick, asking Buildbucket for the build status
[15:58:25.724] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:25.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:118:0) after 1m0s
[15:59:25.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:118:0)
[15:59:25.791] Timer tick, asking Buildbucket for the build status
[15:59:28.556] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:28.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:119:0) after 1m0s
[16:00:28.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:119:0)
[16:00:28.613] Timer tick, asking Buildbucket for the build status
[16:00:28.817] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:28.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:120:0) after 1m0s
[16:01:28.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:120:0)
[16:01:28.955] Timer tick, asking Buildbucket for the build status
[16:01:29.756] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:29.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:121:0) after 1m0s
[16:02:29.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:121:0)
[16:02:29.897] Timer tick, asking Buildbucket for the build status
[16:02:30.321] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:122:0) after 1m0s
[16:03:30.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:122:0)
[16:03:30.407] Timer tick, asking Buildbucket for the build status
[16:03:32.757] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:32.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:123:0) after 1m0s
[16:04:32.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:123:0)
[16:04:32.776] Timer tick, asking Buildbucket for the build status
[16:04:33.159] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:33.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:124:0) after 1m0s
[16:05:33.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:124:0)
[16:05:33.210] Timer tick, asking Buildbucket for the build status
[16:05:33.349] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:125:0) after 1m0s
[16:06:33.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:125:0)
[16:06:33.496] Timer tick, asking Buildbucket for the build status
[16:06:33.867] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:33.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:126:0) after 1m0s
[16:07:33.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:126:0)
[16:07:33.892] Timer tick, asking Buildbucket for the build status
[16:07:34.279] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:34.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:127:0) after 1m0s
[16:08:34.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:127:0)
[16:08:34.391] Timer tick, asking Buildbucket for the build status
[16:08:34.950] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:128:0) after 1m0s
[16:09:35.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:128:0)
[16:09:35.021] Timer tick, asking Buildbucket for the build status
[16:09:35.247] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:35.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:129:0) after 1m0s
[16:10:35.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:129:0)
[16:10:35.369] Timer tick, asking Buildbucket for the build status
[16:10:36.292] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:36.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:130:0) after 1m0s
[16:11:36.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:130:0)
[16:11:36.517] Timer tick, asking Buildbucket for the build status
[16:11:36.660] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:36.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:131:0) after 1m0s
[16:12:36.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:131:0)
[16:12:36.689] Timer tick, asking Buildbucket for the build status
[16:12:37.154] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:37.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:132:0) after 1m0s
[16:13:37.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:132:0)
[16:13:37.895] Timer tick, asking Buildbucket for the build status
[16:13:38.221] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:38.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:133:0) after 1m0s
[16:14:39.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:133:0)
[16:14:39.276] Timer tick, asking Buildbucket for the build status
[16:14:39.745] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:39.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:134:0) after 1m0s
[16:15:39.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:134:0)
[16:15:39.882] Timer tick, asking Buildbucket for the build status
[16:15:40.045] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:40.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:135:0) after 1m0s
[16:16:40.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:135:0)
[16:16:40.118] Timer tick, asking Buildbucket for the build status
[16:16:40.296] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:40.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:136:0) after 1m0s
[16:17:40.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:136:0)
[16:17:40.412] Timer tick, asking Buildbucket for the build status
[16:17:41.192] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:41.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:137:0) after 1m0s
[16:18:41.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:137:0)
[16:18:41.456] Timer tick, asking Buildbucket for the build status
[16:18:43.508] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:43.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:138:0) after 1m0s
[16:19:43.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:138:0)
[16:19:43.534] Timer tick, asking Buildbucket for the build status
[16:19:44.384] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:139:0) after 1m0s
[16:20:44.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:139:0)
[16:20:44.412] Timer tick, asking Buildbucket for the build status
[16:20:45.673] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:45.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:140:0) after 1m0s
[16:21:45.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:140:0)
[16:21:45.703] Timer tick, asking Buildbucket for the build status
[16:21:47.538] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:47.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:141:0) after 1m0s
[16:22:47.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:141:0)
[16:22:47.619] Timer tick, asking Buildbucket for the build status
[16:22:47.867] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:47.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:142:0) after 1m0s
[16:23:47.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:142:0)
[16:23:47.964] Timer tick, asking Buildbucket for the build status
[16:23:48.251] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:48.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:143:0) after 1m0s
[16:24:48.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:143:0)
[16:24:48.502] Timer tick, asking Buildbucket for the build status
[16:24:48.689] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:48.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:144:0) after 1m0s
[16:25:48.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:144:0)
[16:25:48.800] Timer tick, asking Buildbucket for the build status
[16:25:49.048] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:49.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:145:0) after 1m0s
[16:26:49.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:145:0)
[16:26:49.278] Timer tick, asking Buildbucket for the build status
[16:26:50.390] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:50.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:146:0) after 1m0s
[16:27:50.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:146:0)
[16:27:50.444] Timer tick, asking Buildbucket for the build status
[16:27:50.721] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:50.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:147:0) after 1m0s
[16:28:50.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:147:0)
[16:28:50.868] Timer tick, asking Buildbucket for the build status
[16:28:51.100] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:51.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:148:0) after 1m0s
[16:29:51.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:148:0)
[16:29:51.228] Timer tick, asking Buildbucket for the build status
[16:29:51.509] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:51.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:149:0) after 1m0s
[16:30:51.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:149:0)
[16:30:51.674] Timer tick, asking Buildbucket for the build status
[16:30:51.904] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:150:0) after 1m0s
[16:31:51.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:150:0)
[16:31:51.994] Timer tick, asking Buildbucket for the build status
[16:31:53.584] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:53.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:151:0) after 1m0s
[16:32:53.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:151:0)
[16:32:53.675] Timer tick, asking Buildbucket for the build status
[16:32:53.993] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:53.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:152:0) after 1m0s
[16:33:54.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:152:0)
[16:33:54.242] Timer tick, asking Buildbucket for the build status
[16:33:54.420] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:54.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:153:0) after 1m0s
[16:34:54.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:153:0)
[16:34:54.731] Timer tick, asking Buildbucket for the build status
[16:34:55.167] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:55.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:154:0) after 1m0s
[16:35:55.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:154:0)
[16:35:55.423] Timer tick, asking Buildbucket for the build status
[16:35:55.974] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:55.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:155:0) after 1m0s
[16:36:56.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:155:0)
[16:36:56.439] Timer tick, asking Buildbucket for the build status
[16:36:56.951] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:56.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:156:0) after 1m0s
[16:37:57.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:156:0)
[16:37:57.276] Timer tick, asking Buildbucket for the build status
[16:37:57.447] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:57.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:157:0) after 1m0s
[16:38:57.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:157:0)
[16:38:57.842] Timer tick, asking Buildbucket for the build status
[16:38:58.749] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:58.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:158:0) after 1m0s
[16:39:59.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:158:0)
[16:39:59.122] Timer tick, asking Buildbucket for the build status
[16:39:59.887] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:59.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:159:0) after 1m0s
[16:41:00.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:159:0)
[16:41:00.208] Timer tick, asking Buildbucket for the build status
[16:41:00.543] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:00.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:160:0) after 1m0s
[16:42:00.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:160:0)
[16:42:00.794] Timer tick, asking Buildbucket for the build status
[16:42:01.391] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:01.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:161:0) after 1m0s
[16:43:02.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:161:0)
[16:43:02.317] Timer tick, asking Buildbucket for the build status
[16:43:02.622] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:02.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:162:0) after 1m0s
[16:44:02.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:162:0)
[16:44:02.798] Timer tick, asking Buildbucket for the build status
[16:44:03.403] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:03.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:163:0) after 1m0s
[16:45:03.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:163:0)
[16:45:03.552] Timer tick, asking Buildbucket for the build status
[16:45:03.744] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:03.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:164:0) after 1m0s
[16:46:03.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:164:0)
[16:46:03.916] Timer tick, asking Buildbucket for the build status
[16:46:04.393] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:04.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:165:0) after 1m0s
[16:47:04.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:165:0)
[16:47:04.431] Timer tick, asking Buildbucket for the build status
[16:47:04.623] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:04.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:166:0) after 1m0s
[16:48:04.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:166:0)
[16:48:04.724] Timer tick, asking Buildbucket for the build status
[16:48:05.079] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:05.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:167:0) after 1m0s
[16:49:05.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:167:0)
[16:49:05.141] Timer tick, asking Buildbucket for the build status
[16:49:05.422] Build 8894542673142692224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:05.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059972735588362144:168:0) after 1m0s
[16:49:33.198] Received PubSub notification, asking Buildbucket for the build status
[16:49:33.567] Build 8894542673142692224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:49:33.567] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575910172276199",
"created_by": "project:chromium",
"created_ts": "1575900118652143",
"id": "8894542673142692224",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb726b5012a177d901a44356f25fa6b1f9172f3d\"}}",
"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-lz5n\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15416, \"got_angle_revision\": \"5a1add39e987d1734edc9375988fd790af7d089a\", \"got_dawn_revision\": \"dc3317da6cd5242e525d3230516cfd2bbff25fe9\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"eb726b5012a177d901a44356f25fa6b1f9172f3d\", \"got_revision_cp\": \"refs/heads/master@{#722921}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"31916f494c2eca2ee3257733812ce21aa8f2e756\", \"got_v8_revision\": \"69827db645fcece065bf16a795a4ec8d3a51057f\", \"got_v8_revision_cp\": \"refs/heads/8.0.426@{#2}\", \"got_webrtc_revision\": \"dfbfb46062458cf4a86318e698ce1d1dab145753\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30034}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb726b5012a177d901a44356f25fa6b1f9172f3d\"}, \"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-lz5n\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4702-f6d98f9\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575900124514738",
"status": "COMPLETED",
"status_changed_ts": "1575910172538339",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15416",
"builder:Windows deterministic",
"buildset:commit/git/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb726b5012a177d901a44356f25fa6b1f9172f3d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059972735588362144",
"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/8894542673142692224/+/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:4903c90d196e2510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575910172545563",
"url": "https://ci.chromium.org/b/8894542673142692224",
"utcnow_ts": "1575910173552096"
}
}
[16:49:33.567] Invocation finished in 2h47m36.631758117s with status SUCCEEDED