[17:07:38.734] New invocation is queued and will start shortly
[17:07:40.015] Starting the invocation (attempt 1)
[17:07:40.079] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:07:40.079] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:07:40.079] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071829255184873552",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1d58980c0fc4aed6176a0c08139edc47962e6714\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9071829255184873552",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/1d58980c0fc4aed6176a0c08139edc47962e6714",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d58980c0fc4aed6176a0c08139edc47962e6714",
"gitiles_ref:refs/heads/master"
]
}
[17:07:42.190] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564592861141501",
"id": "8906399191994935376",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d58980c0fc4aed6176a0c08139edc47962e6714\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564592861922135",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14296",
"builder:Windows deterministic",
"buildset:commit/git/1d58980c0fc4aed6176a0c08139edc47962e6714",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d58980c0fc4aed6176a0c08139edc47962e6714",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071829255184873552",
"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/8906399191994935376/+/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": "1564592861922239",
"url": "https://ci.chromium.org/b/8906399191994935376",
"utcnow_ts": "1564592862120055"
}
}
[17:07:42.190] Task URL: https://ci.chromium.org/b/8906399191994935376
[17:07:42.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:2:0) after 1m0s
[17:08:42.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:2:0)
[17:08:42.236] Timer tick, asking Buildbucket for the build status
[17:08:42.475] Build 8906399191994935376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:42.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:3:0) after 1m0s
[17:09:42.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:3:0)
[17:09:42.657] Timer tick, asking Buildbucket for the build status
[17:09:43.212] Build 8906399191994935376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:43.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:4:0) after 1m0s
[17:09:55.728] Received PubSub notification, asking Buildbucket for the build status
[17:09:56.025] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:43.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:4:0)
[17:10:43.239] Timer tick, asking Buildbucket for the build status
[17:10:43.811] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:43.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:6:0) after 1m0s
[17:11:43.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:6:0)
[17:11:43.906] Timer tick, asking Buildbucket for the build status
[17:11:44.510] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:7:0) after 1m0s
[17:12:44.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:7:0)
[17:12:44.571] Timer tick, asking Buildbucket for the build status
[17:12:45.705] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:45.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:8:0) after 1m0s
[17:13:45.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:8:0)
[17:13:45.712] Timer tick, asking Buildbucket for the build status
[17:13:45.849] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:45.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:9:0) after 1m0s
[17:14:45.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:9:0)
[17:14:45.912] Timer tick, asking Buildbucket for the build status
[17:14:46.614] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:46.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:10:0) after 1m0s
[17:15:46.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:10:0)
[17:15:46.684] Timer tick, asking Buildbucket for the build status
[17:15:46.892] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:46.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:11:0) after 1m0s
[17:16:46.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:11:0)
[17:16:46.979] Timer tick, asking Buildbucket for the build status
[17:16:47.317] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:47.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:12:0) after 1m0s
[17:17:47.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:12:0)
[17:17:47.349] Timer tick, asking Buildbucket for the build status
[17:17:47.641] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:47.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:13:0) after 1m0s
[17:18:47.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:13:0)
[17:18:47.731] Timer tick, asking Buildbucket for the build status
[17:18:48.218] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:48.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:14:0) after 1m0s
[17:19:48.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:14:0)
[17:19:48.206] Timer tick, asking Buildbucket for the build status
[17:19:48.778] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:48.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:15:0) after 1m0s
[17:20:48.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:15:0)
[17:20:48.825] Timer tick, asking Buildbucket for the build status
[17:20:50.985] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:50.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:16:0) after 1m0s
[17:21:51.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:16:0)
[17:21:51.023] Timer tick, asking Buildbucket for the build status
[17:21:51.153] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:51.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:17:0) after 1m0s
[17:22:51.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:17:0)
[17:22:51.183] Timer tick, asking Buildbucket for the build status
[17:22:52.474] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:52.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:18:0) after 1m0s
[17:23:52.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:18:0)
[17:23:52.531] Timer tick, asking Buildbucket for the build status
[17:23:52.732] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:52.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:19:0) after 1m0s
[17:24:52.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:19:0)
[17:24:52.794] Timer tick, asking Buildbucket for the build status
[17:24:54.826] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:54.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:20:0) after 1m0s
[17:25:54.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:20:0)
[17:25:54.880] Timer tick, asking Buildbucket for the build status
[17:25:55.407] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:55.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:21:0) after 1m0s
[17:26:55.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:21:0)
[17:26:55.434] Timer tick, asking Buildbucket for the build status
[17:26:55.601] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:55.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:22:0) after 1m0s
[17:27:55.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:22:0)
[17:27:55.728] Timer tick, asking Buildbucket for the build status
[17:27:56.675] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:56.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:23:0) after 1m0s
[17:28:56.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:23:0)
[17:28:56.750] Timer tick, asking Buildbucket for the build status
[17:28:57.014] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:57.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:24:0) after 1m0s
[17:29:57.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:24:0)
[17:29:57.107] Timer tick, asking Buildbucket for the build status
[17:29:57.218] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:57.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:25:0) after 1m0s
[17:30:57.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:25:0)
[17:30:57.278] Timer tick, asking Buildbucket for the build status
[17:30:57.945] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:57.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:26:0) after 1m0s
[17:31:58.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:26:0)
[17:31:58.134] Timer tick, asking Buildbucket for the build status
[17:31:58.479] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:58.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:27:0) after 1m0s
[17:32:58.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:27:0)
[17:32:58.502] Timer tick, asking Buildbucket for the build status
[17:32:58.709] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:58.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:28:0) after 1m0s
[17:33:58.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:28:0)
[17:33:58.761] Timer tick, asking Buildbucket for the build status
[17:33:59.434] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:59.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:29:0) after 1m0s
[17:34:59.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:29:0)
[17:34:59.526] Timer tick, asking Buildbucket for the build status
[17:34:59.761] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:59.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:30:0) after 1m0s
[17:35:59.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:30:0)
[17:35:59.825] Timer tick, asking Buildbucket for the build status
[17:35:59.974] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:59.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:31:0) after 1m0s
[17:37:00.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:31:0)
[17:37:00.022] Timer tick, asking Buildbucket for the build status
[17:37:00.481] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:00.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:32:0) after 1m0s
[17:38:00.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:32:0)
[17:38:00.478] Timer tick, asking Buildbucket for the build status
[17:38:01.227] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:01.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:33:0) after 1m0s
[17:39:01.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:33:0)
[17:39:01.300] Timer tick, asking Buildbucket for the build status
[17:39:01.482] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:01.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:34:0) after 1m0s
[17:40:01.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:34:0)
[17:40:01.461] Timer tick, asking Buildbucket for the build status
[17:40:01.586] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:01.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:35:0) after 1m0s
[17:41:01.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:35:0)
[17:41:01.637] Timer tick, asking Buildbucket for the build status
[17:41:02.329] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:02.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:36:0) after 1m0s
[17:42:02.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:36:0)
[17:42:02.362] Timer tick, asking Buildbucket for the build status
[17:42:02.558] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:02.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:37:0) after 1m0s
[17:43:02.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:37:0)
[17:43:02.630] Timer tick, asking Buildbucket for the build status
[17:43:03.108] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:03.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:38:0) after 1m0s
[17:44:03.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:38:0)
[17:44:03.113] Timer tick, asking Buildbucket for the build status
[17:44:03.333] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:03.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:39:0) after 1m0s
[17:45:03.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:39:0)
[17:45:03.410] Timer tick, asking Buildbucket for the build status
[17:45:03.657] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:03.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:40:0) after 1m0s
[17:46:03.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:40:0)
[17:46:03.714] Timer tick, asking Buildbucket for the build status
[17:46:04.138] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:04.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:41:0) after 1m0s
[17:47:04.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:41:0)
[17:47:04.273] Timer tick, asking Buildbucket for the build status
[17:47:05.395] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:05.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:42:0) after 1m0s
[17:48:05.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:42:0)
[17:48:05.494] Timer tick, asking Buildbucket for the build status
[17:48:05.766] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:05.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:43:0) after 1m0s
[17:49:05.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:43:0)
[17:49:05.792] Timer tick, asking Buildbucket for the build status
[17:49:07.627] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:07.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:44:0) after 1m0s
[17:50:07.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:44:0)
[17:50:07.655] Timer tick, asking Buildbucket for the build status
[17:50:08.494] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:08.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:45:0) after 1m0s
[17:51:08.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:45:0)
[17:51:08.503] Timer tick, asking Buildbucket for the build status
[17:51:09.334] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:09.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:46:0) after 1m0s
[17:52:09.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:46:0)
[17:52:09.355] Timer tick, asking Buildbucket for the build status
[17:52:09.508] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:09.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:47:0) after 1m0s
[17:53:09.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:47:0)
[17:53:09.537] Timer tick, asking Buildbucket for the build status
[17:53:09.682] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:09.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:48:0) after 1m0s
[17:54:09.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:48:0)
[17:54:09.682] Timer tick, asking Buildbucket for the build status
[17:54:09.961] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:09.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:49:0) after 1m0s
[17:55:09.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:49:0)
[17:55:09.968] Timer tick, asking Buildbucket for the build status
[17:55:10.139] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:10.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:50:0) after 1m0s
[17:56:10.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:50:0)
[17:56:10.153] Timer tick, asking Buildbucket for the build status
[17:56:10.784] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:10.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:51:0) after 1m0s
[17:57:10.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:51:0)
[17:57:10.807] Timer tick, asking Buildbucket for the build status
[17:57:11.208] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:11.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:52:0) after 1m0s
[17:58:11.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:52:0)
[17:58:11.303] Timer tick, asking Buildbucket for the build status
[17:58:11.664] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:11.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:53:0) after 1m0s
[17:59:11.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:53:0)
[17:59:11.666] Timer tick, asking Buildbucket for the build status
[17:59:11.953] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:11.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:54:0) after 1m0s
[18:00:12.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:54:0)
[18:00:12.019] Timer tick, asking Buildbucket for the build status
[18:00:12.286] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:12.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:55:0) after 1m0s
[18:01:12.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:55:0)
[18:01:12.326] Timer tick, asking Buildbucket for the build status
[18:01:12.457] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:12.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:56:0) after 1m0s
[18:02:12.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:56:0)
[18:02:12.496] Timer tick, asking Buildbucket for the build status
[18:02:12.762] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:12.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:57:0) after 1m0s
[18:03:12.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:57:0)
[18:03:12.882] Timer tick, asking Buildbucket for the build status
[18:03:13.129] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:13.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:58:0) after 1m0s
[18:04:13.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:58:0)
[18:04:13.268] Timer tick, asking Buildbucket for the build status
[18:04:14.049] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:59:0) after 1m0s
[18:05:14.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:59:0)
[18:05:14.108] Timer tick, asking Buildbucket for the build status
[18:05:14.554] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:14.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:60:0) after 1m0s
[18:06:14.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:60:0)
[18:06:14.647] Timer tick, asking Buildbucket for the build status
[18:06:17.333] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:17.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:61:0) after 1m0s
[18:07:17.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:61:0)
[18:07:17.428] Timer tick, asking Buildbucket for the build status
[18:07:20.987] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:20.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:62:0) after 1m0s
[18:08:21.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:62:0)
[18:08:21.242] Timer tick, asking Buildbucket for the build status
[18:08:22.449] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:22.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:63:0) after 1m0s
[18:09:22.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:63:0)
[18:09:22.762] Timer tick, asking Buildbucket for the build status
[18:09:24.410] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:24.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:64:0) after 1m0s
[18:10:24.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:64:0)
[18:10:24.475] Timer tick, asking Buildbucket for the build status
[18:10:24.669] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:24.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:65:0) after 1m0s
[18:11:24.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:65:0)
[18:11:24.700] Timer tick, asking Buildbucket for the build status
[18:11:27.689] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:27.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:66:0) after 1m0s
[18:12:27.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:66:0)
[18:12:27.765] Timer tick, asking Buildbucket for the build status
[18:12:27.980] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:27.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:67:0) after 1m0s
[18:13:27.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:67:0)
[18:13:27.979] Timer tick, asking Buildbucket for the build status
[18:13:28.131] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:28.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:68:0) after 1m0s
[18:14:28.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:68:0)
[18:14:28.170] Timer tick, asking Buildbucket for the build status
[18:14:28.385] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:28.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:69:0) after 1m0s
[18:15:28.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:69:0)
[18:15:28.523] Timer tick, asking Buildbucket for the build status
[18:15:28.907] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:28.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:70:0) after 1m0s
[18:16:28.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:70:0)
[18:16:28.930] Timer tick, asking Buildbucket for the build status
[18:16:29.098] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:29.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:71:0) after 1m0s
[18:17:29.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:71:0)
[18:17:29.199] Timer tick, asking Buildbucket for the build status
[18:17:29.385] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:29.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:72:0) after 1m0s
[18:18:29.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:72:0)
[18:18:29.511] Timer tick, asking Buildbucket for the build status
[18:18:29.676] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:29.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:73:0) after 1m0s
[18:19:29.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:73:0)
[18:19:29.772] Timer tick, asking Buildbucket for the build status
[18:19:29.910] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:29.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:74:0) after 1m0s
[18:20:30.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:74:0)
[18:20:30.056] Timer tick, asking Buildbucket for the build status
[18:20:30.400] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:30.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:75:0) after 1m0s
[18:21:30.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:75:0)
[18:21:30.556] Timer tick, asking Buildbucket for the build status
[18:21:30.715] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:30.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:76:0) after 1m0s
[18:22:30.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:76:0)
[18:22:30.854] Timer tick, asking Buildbucket for the build status
[18:22:30.998] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:77:0) after 1m0s
[18:23:31.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:77:0)
[18:23:31.070] Timer tick, asking Buildbucket for the build status
[18:23:31.930] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:31.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:78:0) after 1m0s
[18:24:32.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:78:0)
[18:24:32.053] Timer tick, asking Buildbucket for the build status
[18:24:32.361] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:79:0) after 1m0s
[18:25:32.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:79:0)
[18:25:32.592] Timer tick, asking Buildbucket for the build status
[18:25:33.253] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:33.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:80:0) after 1m0s
[18:26:33.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:80:0)
[18:26:33.280] Timer tick, asking Buildbucket for the build status
[18:26:33.883] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:33.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:81:0) after 1m0s
[18:27:34.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:81:0)
[18:27:34.063] Timer tick, asking Buildbucket for the build status
[18:27:34.753] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:34.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:82:0) after 1m0s
[18:28:34.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:82:0)
[18:28:34.810] Timer tick, asking Buildbucket for the build status
[18:28:35.564] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:35.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:83:0) after 1m0s
[18:29:35.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:83:0)
[18:29:35.669] Timer tick, asking Buildbucket for the build status
[18:29:36.406] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:36.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:84:0) after 1m0s
[18:30:36.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:84:0)
[18:30:36.558] Timer tick, asking Buildbucket for the build status
[18:30:37.010] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:37.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:85:0) after 1m0s
[18:31:37.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:85:0)
[18:31:37.001] Timer tick, asking Buildbucket for the build status
[18:31:38.732] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:38.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:86:0) after 1m0s
[18:32:38.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:86:0)
[18:32:38.754] Timer tick, asking Buildbucket for the build status
[18:32:39.142] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:39.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:87:0) after 1m0s
[18:33:39.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:87:0)
[18:33:39.212] Timer tick, asking Buildbucket for the build status
[18:33:39.628] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:39.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:88:0) after 1m0s
[18:34:39.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:88:0)
[18:34:39.768] Timer tick, asking Buildbucket for the build status
[18:34:40.645] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:40.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:89:0) after 1m0s
[18:35:40.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:89:0)
[18:35:40.732] Timer tick, asking Buildbucket for the build status
[18:35:40.887] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:40.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:90:0) after 1m0s
[18:36:41.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:90:0)
[18:36:41.006] Timer tick, asking Buildbucket for the build status
[18:36:41.482] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:41.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:91:0) after 1m0s
[18:37:41.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:91:0)
[18:37:41.528] Timer tick, asking Buildbucket for the build status
[18:37:41.932] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:41.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:92:0) after 1m0s
[18:38:42.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:92:0)
[18:38:42.155] Timer tick, asking Buildbucket for the build status
[18:38:42.460] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:42.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:93:0) after 1m0s
[18:39:42.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:93:0)
[18:39:42.549] Timer tick, asking Buildbucket for the build status
[18:39:42.913] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:42.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:94:0) after 1m0s
[18:40:43.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:94:0)
[18:40:43.046] Timer tick, asking Buildbucket for the build status
[18:40:43.238] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:43.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:95:0) after 1m0s
[18:41:43.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:95:0)
[18:41:43.320] Timer tick, asking Buildbucket for the build status
[18:41:44.230] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:44.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:96:0) after 1m0s
[18:42:44.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:96:0)
[18:42:44.321] Timer tick, asking Buildbucket for the build status
[18:42:44.720] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:44.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:97:0) after 1m0s
[18:43:44.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:97:0)
[18:43:44.792] Timer tick, asking Buildbucket for the build status
[18:43:46.413] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:46.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:98:0) after 1m0s
[18:44:46.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:98:0)
[18:44:46.442] Timer tick, asking Buildbucket for the build status
[18:44:48.864] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:99:0) after 1m0s
[18:45:48.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:99:0)
[18:45:48.955] Timer tick, asking Buildbucket for the build status
[18:45:49.600] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:49.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:100:0) after 1m0s
[18:46:49.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:100:0)
[18:46:49.635] Timer tick, asking Buildbucket for the build status
[18:46:49.858] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:49.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:101:0) after 1m0s
[18:47:49.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:101:0)
[18:47:49.939] Timer tick, asking Buildbucket for the build status
[18:47:50.894] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:50.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:102:0) after 1m0s
[18:48:50.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:102:0)
[18:48:50.926] Timer tick, asking Buildbucket for the build status
[18:48:54.489] Build 8906399191994935376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:54.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071829255184873552:103:0) after 1m0s
[18:49:14.478] Received PubSub notification, asking Buildbucket for the build status
[18:49:14.892] Build 8906399191994935376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:49:14.892] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564598953972696",
"created_by": "project:chromium",
"created_ts": "1564592861141501",
"failure_reason": "BUILD_FAILURE",
"id": "8906399191994935376",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d58980c0fc4aed6176a0c08139edc47962e6714\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"```\\n[83339/83361] LINK gcp_unittests.exe gcp_unittests.exe.pdb\\nFAILED: gcp_unittests.exe gcp_unittests.exe.pdb\\nninja -t msvc -e environment.x86 -- ../../third_party/llvm-build/Release+Asserts/bin/lld-link.exe /nologo /OUT:./gcp_unittests.exe /PDB:./gcp_unittests.exe.pdb @./gcp_unittests.exe.rsp\\nlld-link: error: could not get the buffer for the member defining symbol ??0DictionaryCache@RuleBasedBreakIterator@icu_64@@QAE@PAV12@AAW4UErrorCode@@@Z: obj/third_party/icu/icuuc.lib(obj/third_party/icu\\\\icuuc/rbbi_cache.obj): Insufficient system resources exist to complete the requested service.\\n\\n\\n```\"}, \"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-03yq\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14296, \"got_angle_revision\": \"34ebecc19c6bbee5d7f9270bc2f0418ce6b8907d\", \"got_dawn_revision\": \"351ea23830db3bfcf1e8abd7f9241739d69fc001\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"1d58980c0fc4aed6176a0c08139edc47962e6714\", \"got_revision_cp\": \"refs/heads/master@{#682774}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"da479f0f9842195e0a19168ac3bbe926563a2593\", \"got_v8_revision_cp\": \"refs/heads/7.8.39@{#1}\", \"got_webrtc_revision\": \"97e015fa8e5a57a6fc6fcb9d727b6262048e30ea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28719}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1d58980c0fc4aed6176a0c08139edc47962e6714\"}, \"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-03yq\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"```\\n[83339/83361] LINK gcp_unittests.exe gcp_unittests.exe.pdb\\nFAILED: gcp_unittests.exe gcp_unittests.exe.pdb\\nninja -t msvc -e environment.x86 -- ../../third_party/llvm-build/Release+Asserts/bin/lld-link.exe /nologo /OUT:./gcp_unittests.exe /PDB:./gcp_unittests.exe.pdb @./gcp_unittests.exe.rsp\\nlld-link: error: could not get the buffer for the member defining symbol ??0DictionaryCache@RuleBasedBreakIterator@icu_64@@QAE@PAV12@AAW4UErrorCode@@@Z: obj/third_party/icu/icuuc.lib(obj/third_party/icu\\\\icuuc/rbbi_cache.obj): Insufficient system resources exist to complete the requested service.\\n\\n\\n```\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564592990078316",
"status": "COMPLETED",
"status_changed_ts": "1564592995056386",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14296",
"builder:Windows deterministic",
"buildset:commit/git/1d58980c0fc4aed6176a0c08139edc47962e6714",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d58980c0fc4aed6176a0c08139edc47962e6714",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071829255184873552",
"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/8906399191994935376/+/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:4661d1fd0173a010",
"user_agent:luci-scheduler"
],
"updated_ts": "1564598954100191",
"url": "https://ci.chromium.org/b/8906399191994935376",
"utcnow_ts": "1564598954850583"
}
}
[18:49:14.892] Invocation finished in 1h41m36.176334574s with status FAILED