[20:34:47.356] New invocation is queued and will start shortly
[20:34:48.759] Starting the invocation (attempt 1)
[20:34:48.811] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:34:48.811] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:34:48.811] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030866394014584288",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030866394014584288",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master"
]
}
[20:34:49.444] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603658088891343",
"id": "8865436331741042336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603658089312594",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177006",
"builder:Linux Builder (dbg)",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030866394014584288",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865436331741042336/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1603658089312747",
"url": "https://ci.chromium.org/b/8865436331741042336",
"utcnow_ts": "1603658089436632"
}
}
[20:34:49.444] Task URL: https://ci.chromium.org/b/8865436331741042336
[20:34:49.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:2:0) after 1m0s
[20:35:49.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:2:0)
[20:35:49.496] Timer tick, asking Buildbucket for the build status
[20:35:49.681] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:49.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:3:0) after 1m0s
[20:36:49.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:3:0)
[20:36:49.713] Timer tick, asking Buildbucket for the build status
[20:36:49.778] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:49.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:4:0) after 1m0s
[20:37:49.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:4:0)
[20:37:49.788] Timer tick, asking Buildbucket for the build status
[20:37:49.875] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:49.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:5:0) after 1m0s
[20:38:49.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:5:0)
[20:38:49.928] Timer tick, asking Buildbucket for the build status
[20:38:49.996] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:49.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:6:0) after 1m0s
[20:39:49.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:6:0)
[20:39:49.987] Timer tick, asking Buildbucket for the build status
[20:39:50.131] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:50.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:7:0) after 1m0s
[20:40:50.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:7:0)
[20:40:50.106] Timer tick, asking Buildbucket for the build status
[20:40:50.221] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:50.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:8:0) after 1m0s
[20:41:50.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:8:0)
[20:41:50.242] Timer tick, asking Buildbucket for the build status
[20:41:50.311] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:50.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:9:0) after 1m0s
[20:42:50.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:9:0)
[20:42:50.331] Timer tick, asking Buildbucket for the build status
[20:42:50.416] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:50.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:10:0) after 1m0s
[20:43:50.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:10:0)
[20:43:50.436] Timer tick, asking Buildbucket for the build status
[20:43:53.423] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:53.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:11:0) after 1m0s
[20:44:53.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:11:0)
[20:44:53.457] Timer tick, asking Buildbucket for the build status
[20:44:53.549] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:53.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:12:0) after 1m0s
[20:45:53.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:12:0)
[20:45:53.600] Timer tick, asking Buildbucket for the build status
[20:45:53.678] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:53.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:13:0) after 1m0s
[20:46:53.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:13:0)
[20:46:53.726] Timer tick, asking Buildbucket for the build status
[20:46:54.267] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:54.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:14:0) after 1m0s
[20:47:54.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:14:0)
[20:47:54.292] Timer tick, asking Buildbucket for the build status
[20:47:54.425] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:54.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:15:0) after 1m0s
[20:48:54.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:15:0)
[20:48:54.432] Timer tick, asking Buildbucket for the build status
[20:48:54.503] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:54.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:16:0) after 1m0s
[20:49:54.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:16:0)
[20:49:54.529] Timer tick, asking Buildbucket for the build status
[20:49:54.634] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:54.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:17:0) after 1m0s
[20:50:54.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:17:0)
[20:50:54.615] Timer tick, asking Buildbucket for the build status
[20:50:54.770] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:54.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:18:0) after 1m0s
[20:51:54.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:18:0)
[20:51:54.794] Timer tick, asking Buildbucket for the build status
[20:51:55.014] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:55.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:19:0) after 1m0s
[20:52:55.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:19:0)
[20:52:55.035] Timer tick, asking Buildbucket for the build status
[20:52:55.107] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:55.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:20:0) after 1m0s
[20:53:55.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:20:0)
[20:53:55.133] Timer tick, asking Buildbucket for the build status
[20:53:55.223] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:55.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:21:0) after 1m0s
[20:54:55.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:21:0)
[20:54:55.262] Timer tick, asking Buildbucket for the build status
[20:54:55.358] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:55.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:22:0) after 1m0s
[20:55:55.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:22:0)
[20:55:55.381] Timer tick, asking Buildbucket for the build status
[20:55:55.524] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:55.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:23:0) after 1m0s
[20:56:55.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:23:0)
[20:56:55.547] Timer tick, asking Buildbucket for the build status
[20:56:55.619] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:55.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:24:0) after 1m0s
[20:57:55.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:24:0)
[20:57:55.690] Timer tick, asking Buildbucket for the build status
[20:57:55.758] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:25:0) after 1m0s
[20:58:55.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:25:0)
[20:58:55.851] Timer tick, asking Buildbucket for the build status
[20:58:56.015] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:56.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:26:0) after 1m0s
[20:59:56.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:26:0)
[20:59:56.110] Timer tick, asking Buildbucket for the build status
[20:59:56.328] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:56.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:27:0) after 1m0s
[21:00:56.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:27:0)
[21:00:56.338] Timer tick, asking Buildbucket for the build status
[21:00:56.614] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:56.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:28:0) after 1m0s
[21:01:56.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:28:0)
[21:01:56.617] Timer tick, asking Buildbucket for the build status
[21:01:56.809] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:29:0) after 1m0s
[21:02:56.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:29:0)
[21:02:56.871] Timer tick, asking Buildbucket for the build status
[21:02:56.946] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:56.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:30:0) after 1m0s
[21:03:57.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:30:0)
[21:03:57.087] Timer tick, asking Buildbucket for the build status
[21:03:57.184] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:57.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:31:0) after 1m0s
[21:04:57.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:31:0)
[21:04:57.245] Timer tick, asking Buildbucket for the build status
[21:04:57.559] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:57.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:32:0) after 1m0s
[21:05:57.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:32:0)
[21:05:57.616] Timer tick, asking Buildbucket for the build status
[21:05:57.681] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:33:0) after 1m0s
[21:06:57.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:33:0)
[21:06:57.702] Timer tick, asking Buildbucket for the build status
[21:06:57.774] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:34:0) after 1m0s
[21:07:57.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:34:0)
[21:07:57.814] Timer tick, asking Buildbucket for the build status
[21:07:57.895] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:57.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:35:0) after 1m0s
[21:08:57.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:35:0)
[21:08:57.933] Timer tick, asking Buildbucket for the build status
[21:08:57.999] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:57.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:36:0) after 1m0s
[21:09:58.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:36:0)
[21:09:58.065] Timer tick, asking Buildbucket for the build status
[21:09:58.160] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:58.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:37:0) after 1m0s
[21:10:58.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:37:0)
[21:10:58.182] Timer tick, asking Buildbucket for the build status
[21:10:58.251] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:58.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:38:0) after 1m0s
[21:11:58.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:38:0)
[21:11:58.287] Timer tick, asking Buildbucket for the build status
[21:11:58.388] Build 8865436331741042336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:58.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:39:0) after 1m0s
[21:12:49.236] Received PubSub notification, asking Buildbucket for the build status
[21:12:49.393] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:58.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:39:0)
[21:12:58.474] Timer tick, asking Buildbucket for the build status
[21:12:58.585] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:58.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:41:0) after 1m0s
[21:13:58.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:41:0)
[21:13:58.609] Timer tick, asking Buildbucket for the build status
[21:13:58.680] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:58.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:42:0) after 1m0s
[21:14:58.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:42:0)
[21:14:58.704] Timer tick, asking Buildbucket for the build status
[21:14:58.791] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:58.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:43:0) after 1m0s
[21:15:58.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:43:0)
[21:15:58.787] Timer tick, asking Buildbucket for the build status
[21:15:58.896] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:58.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:44:0) after 1m0s
[21:16:58.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:44:0)
[21:16:58.954] Timer tick, asking Buildbucket for the build status
[21:16:59.142] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:59.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:45:0) after 1m0s
[21:17:59.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:45:0)
[21:17:59.267] Timer tick, asking Buildbucket for the build status
[21:17:59.579] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:59.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:46:0) after 1m0s
[21:18:59.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:46:0)
[21:18:59.727] Timer tick, asking Buildbucket for the build status
[21:18:59.780] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:59.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:47:0) after 1m0s
[21:19:59.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:47:0)
[21:19:59.809] Timer tick, asking Buildbucket for the build status
[21:19:59.906] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:59.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:48:0) after 1m0s
[21:20:59.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:48:0)
[21:20:59.930] Timer tick, asking Buildbucket for the build status
[21:21:00.206] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:00.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:49:0) after 1m0s
[21:22:00.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:49:0)
[21:22:00.464] Timer tick, asking Buildbucket for the build status
[21:22:00.523] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:00.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:50:0) after 1m0s
[21:23:01.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:50:0)
[21:23:01.381] Timer tick, asking Buildbucket for the build status
[21:23:01.552] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:01.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:51:0) after 1m0s
[21:24:01.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:51:0)
[21:24:01.624] Timer tick, asking Buildbucket for the build status
[21:24:02.156] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:02.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:52:0) after 1m0s
[21:25:02.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:52:0)
[21:25:02.431] Timer tick, asking Buildbucket for the build status
[21:25:03.001] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:03.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:53:0) after 1m0s
[21:26:03.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:53:0)
[21:26:03.141] Timer tick, asking Buildbucket for the build status
[21:26:03.420] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:03.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:54:0) after 1m0s
[21:27:03.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:54:0)
[21:27:03.637] Timer tick, asking Buildbucket for the build status
[21:27:03.799] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:03.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:55:0) after 1m0s
[21:28:03.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:55:0)
[21:28:03.923] Timer tick, asking Buildbucket for the build status
[21:28:04.101] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:04.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:56:0) after 1m0s
[21:29:04.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:56:0)
[21:29:04.275] Timer tick, asking Buildbucket for the build status
[21:29:04.343] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:04.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:57:0) after 1m0s
[21:30:05.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:57:0)
[21:30:05.825] Timer tick, asking Buildbucket for the build status
[21:30:05.940] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:05.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:58:0) after 1m0s
[21:31:06.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:58:0)
[21:31:06.028] Timer tick, asking Buildbucket for the build status
[21:31:06.096] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:06.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:59:0) after 1m0s
[21:32:06.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:59:0)
[21:32:06.118] Timer tick, asking Buildbucket for the build status
[21:32:06.569] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:06.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:60:0) after 1m0s
[21:33:06.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:60:0)
[21:33:06.725] Timer tick, asking Buildbucket for the build status
[21:33:06.875] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:06.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:61:0) after 1m0s
[21:34:06.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:61:0)
[21:34:06.886] Timer tick, asking Buildbucket for the build status
[21:34:07.041] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:07.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:62:0) after 1m0s
[21:35:07.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:62:0)
[21:35:07.066] Timer tick, asking Buildbucket for the build status
[21:35:07.588] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:07.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:63:0) after 1m0s
[21:36:07.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:63:0)
[21:36:07.666] Timer tick, asking Buildbucket for the build status
[21:36:07.738] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:07.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:64:0) after 1m0s
[21:37:07.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:64:0)
[21:37:07.801] Timer tick, asking Buildbucket for the build status
[21:37:07.864] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:07.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:65:0) after 1m0s
[21:38:07.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:65:0)
[21:38:07.979] Timer tick, asking Buildbucket for the build status
[21:38:08.076] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:08.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:66:0) after 1m0s
[21:39:08.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:66:0)
[21:39:08.308] Timer tick, asking Buildbucket for the build status
[21:39:08.497] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:08.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:67:0) after 1m0s
[21:40:08.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:67:0)
[21:40:08.648] Timer tick, asking Buildbucket for the build status
[21:40:08.771] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:08.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:68:0) after 1m0s
[21:41:09.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:68:0)
[21:41:09.079] Timer tick, asking Buildbucket for the build status
[21:41:09.154] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:09.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:69:0) after 1m0s
[21:42:09.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:69:0)
[21:42:09.216] Timer tick, asking Buildbucket for the build status
[21:42:10.331] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:10.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:70:0) after 1m0s
[21:43:10.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:70:0)
[21:43:10.677] Timer tick, asking Buildbucket for the build status
[21:43:11.167] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:71:0) after 1m0s
[21:44:11.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:71:0)
[21:44:11.311] Timer tick, asking Buildbucket for the build status
[21:44:11.510] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:11.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:72:0) after 1m0s
[21:45:11.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:72:0)
[21:45:11.546] Timer tick, asking Buildbucket for the build status
[21:45:11.722] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:11.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:73:0) after 1m0s
[21:46:11.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:73:0)
[21:46:11.885] Timer tick, asking Buildbucket for the build status
[21:46:11.974] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:11.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:74:0) after 1m0s
[21:47:12.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:74:0)
[21:47:12.034] Timer tick, asking Buildbucket for the build status
[21:47:12.105] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:12.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:75:0) after 1m0s
[21:48:12.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:75:0)
[21:48:12.181] Timer tick, asking Buildbucket for the build status
[21:48:12.245] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:12.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:76:0) after 1m0s
[21:49:12.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:76:0)
[21:49:12.427] Timer tick, asking Buildbucket for the build status
[21:49:13.529] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:13.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:77:0) after 1m0s
[21:50:13.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:77:0)
[21:50:13.621] Timer tick, asking Buildbucket for the build status
[21:50:13.728] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:13.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:78:0) after 1m0s
[21:51:13.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:78:0)
[21:51:13.976] Timer tick, asking Buildbucket for the build status
[21:51:14.382] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:14.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:79:0) after 1m0s
[21:52:14.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:79:0)
[21:52:14.470] Timer tick, asking Buildbucket for the build status
[21:52:14.549] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:14.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:80:0) after 1m0s
[21:53:14.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:80:0)
[21:53:14.656] Timer tick, asking Buildbucket for the build status
[21:53:14.724] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:14.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:81:0) after 1m0s
[21:54:14.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:81:0)
[21:54:14.879] Timer tick, asking Buildbucket for the build status
[21:54:14.961] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:14.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:82:0) after 1m0s
[21:55:15.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:82:0)
[21:55:15.034] Timer tick, asking Buildbucket for the build status
[21:55:15.142] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:83:0) after 1m0s
[21:56:15.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:83:0)
[21:56:15.280] Timer tick, asking Buildbucket for the build status
[21:56:15.357] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:15.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:84:0) after 1m0s
[21:57:15.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:84:0)
[21:57:15.496] Timer tick, asking Buildbucket for the build status
[21:57:15.785] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:15.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:85:0) after 1m0s
[21:58:15.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:85:0)
[21:58:15.893] Timer tick, asking Buildbucket for the build status
[21:58:16.018] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:86:0) after 1m0s
[21:59:16.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:86:0)
[21:59:16.044] Timer tick, asking Buildbucket for the build status
[21:59:16.129] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:16.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:87:0) after 1m0s
[22:00:16.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:87:0)
[22:00:16.210] Timer tick, asking Buildbucket for the build status
[22:00:16.524] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:16.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:88:0) after 1m0s
[22:01:16.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:88:0)
[22:01:16.577] Timer tick, asking Buildbucket for the build status
[22:01:16.784] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:16.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:89:0) after 1m0s
[22:02:16.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:89:0)
[22:02:16.831] Timer tick, asking Buildbucket for the build status
[22:02:16.892] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:16.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:90:0) after 1m0s
[22:03:16.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:90:0)
[22:03:16.975] Timer tick, asking Buildbucket for the build status
[22:03:17.044] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:17.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:91:0) after 1m0s
[22:04:17.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:91:0)
[22:04:17.121] Timer tick, asking Buildbucket for the build status
[22:04:17.184] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:17.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:92:0) after 1m0s
[22:05:17.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:92:0)
[22:05:17.388] Timer tick, asking Buildbucket for the build status
[22:05:17.529] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:17.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:93:0) after 1m0s
[22:06:17.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:93:0)
[22:06:17.642] Timer tick, asking Buildbucket for the build status
[22:06:17.727] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:17.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:94:0) after 1m0s
[22:07:17.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:94:0)
[22:07:17.947] Timer tick, asking Buildbucket for the build status
[22:07:18.915] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:18.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:95:0) after 1m0s
[22:08:18.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:95:0)
[22:08:18.955] Timer tick, asking Buildbucket for the build status
[22:08:19.138] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:19.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:96:0) after 1m0s
[22:09:19.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:96:0)
[22:09:19.188] Timer tick, asking Buildbucket for the build status
[22:09:19.287] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:97:0) after 1m0s
[22:10:19.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:97:0)
[22:10:19.265] Timer tick, asking Buildbucket for the build status
[22:10:19.457] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:19.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:98:0) after 1m0s
[22:11:19.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:98:0)
[22:11:19.540] Timer tick, asking Buildbucket for the build status
[22:11:19.923] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:19.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:99:0) after 1m0s
[22:12:20.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:99:0)
[22:12:20.047] Timer tick, asking Buildbucket for the build status
[22:12:20.114] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:20.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:100:0) after 1m0s
[22:13:20.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:100:0)
[22:13:20.312] Timer tick, asking Buildbucket for the build status
[22:13:20.392] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:20.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:101:0) after 1m0s
[22:14:20.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:101:0)
[22:14:20.492] Timer tick, asking Buildbucket for the build status
[22:14:20.653] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:20.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:102:0) after 1m0s
[22:15:20.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:102:0)
[22:15:20.681] Timer tick, asking Buildbucket for the build status
[22:15:20.804] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:20.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:103:0) after 1m0s
[22:16:20.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:103:0)
[22:16:20.918] Timer tick, asking Buildbucket for the build status
[22:16:21.037] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:21.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:104:0) after 1m0s
[22:17:21.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:104:0)
[22:17:21.166] Timer tick, asking Buildbucket for the build status
[22:17:21.267] Build 8865436331741042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:21.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030866394014584288:105:0) after 1m0s
[22:17:42.484] Received PubSub notification, asking Buildbucket for the build status
[22:17:42.549] Build 8865436331741042336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:17:42.549] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603664261691607",
"created_by": "project:chromium",
"created_ts": "1603658088891343",
"id": "8865436331741042336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-91-m395\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177006, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"got_revision_cp\": \"refs/heads/master@{#820632}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"swarm_hashes_refs/heads/master(at){#820632}_without_patch\": {\"absl_hardening_tests\": \"cf95b919440f4e9d3d290c4140babaf3f7313ad9\", \"accessibility_unittests\": \"8e3fba8fa528689ad528e2fe13cabe7fd6c3e79e\", \"angle_unittests\": \"734a11c531806a88890590f8c310b18902909366\", \"app_shell_unittests\": \"abfa443e615051a25a55646d70797f7453cda2e2\", \"aura_unittests\": \"50ffdf4785419967412acb48003e27f9f619de05\", \"base_unittests\": \"494158e2f9c7bf6de39035acb81dd0d5620c9735\", \"base_util_unittests\": \"3fe538ba4ed2cb2388aff8bd8a772cc5d813b367\", \"blink_common_unittests\": \"d963ef8127877099dd844a2841872e9c780e387a\", \"blink_fuzzer_unittests\": \"7deb502bc7a531ad812e23e7bb63c81d8513bed4\", \"blink_heap_unittests\": \"1052599684bcc766f04b92518a1dc87ea46d9fd0\", \"blink_platform_unittests\": \"4e63d2fcad37cd0860726124f93d6d893197506f\", \"blink_python_tests\": \"791456e2a04922db0337876551bef069d9e92875\", \"blink_unittests\": \"c0c16c84faad0132137fe3e53ae6330721ec1eb4\", \"blink_web_tests\": \"0e7b99b8c53bfe228d5cdbab37d0a4021b13cc30\", \"boringssl_crypto_tests\": \"06948eca71bed28647aa4c4c7bc5fe769ea4c24a\", \"boringssl_ssl_tests\": \"0ebf85c31f86b8f3a8cc350e7cb1f7c539360002\", \"browser_tests\": \"61c1809e3a480d2b3a4ef3d10fbd8c753881c55d\", \"capture_unittests\": \"d722255e53c89ca98c65566fe8a589a24780bbd1\", \"cast_unittests\": \"b8a6478b0e9f5872eab1059d93196cb6e4f29745\", \"cc_unittests\": \"af5a5d537a84266140b8087ff8b131172d14e1e3\", \"chrome_app_unittests\": \"8059612d46bf2f15ca3a412afa74eeb8befc6e6f\", \"chromedriver_unittests\": \"b25fd982ec04078e09e5219b179ac7a3f3cf45a4\", \"components_browsertests\": \"c0fb67b462ec2b65536026394ab0b0baef402f52\", \"components_unittests\": \"fdaeab7d7a80a0cfa0bfe109d5b44ab8099cab47\", \"compositor_unittests\": \"cc0932ab634fd1fe8d4f4fff4042c7c07f7c3bd4\", \"content_browsertests\": \"0797ada6dc65caf7a2005be21d5a8fc0901c9ed1\", \"content_shell_crash_test\": \"a2199b5e7b711edb17aefe610529f4366bdd2ab8\", \"content_unittests\": \"423795507f0d36a3367c0ed19b5b264babea5367\", \"crashpad_tests\": \"955dfe5235db031a1317ef0b9646d6654c84e9a6\", \"cronet_tests\": \"997d122c626522949c2ca4c52de40346b4a06cc7\", \"cronet_unittests\": \"bcc304501da03ef1f00b723ce153f7b7bd44e98c\", \"crypto_unittests\": \"8cddcd2c65a9d0e01c96c7b67dae667b53be3ea2\", \"dbus_unittests\": \"82e8cc776150810dfa9aa8627d8acba5dbe68889\", \"device_unittests\": \"991164e7632d9ab2af234fb4390b6d1a46ab34d1\", \"display_unittests\": \"3ba32c2617c001a98cf010397df8f70f83479a33\", \"events_unittests\": \"24101b89e2a5e1dee8ea932de58e6c856880a91f\", \"extension_docserver_python_unittests\": \"9f8dc281ab814e3d85d05e0b3bfe9c0afd87c538\", \"extensions_browsertests\": \"d02651f2a045e275a7b1c3af4004fd557e910b5f\", \"extensions_unittests\": \"7bf8b070b6102272741ef8dde3d0b3bf39a08dba\", \"filesystem_service_unittests\": \"48d86a053aeb4880d46f153c3d8834c00d53d039\", \"flatbuffers_unittests\": \"8004943fa766595d5f2a596771d20719dc1b1f6c\", \"gcm_unit_tests\": \"cf0a582f8d798054ccbf4284beb65107ba0536fb\", \"gfx_unittests\": \"ac463e0a6630f7e6a74a3c84209ac8ea08a4ee6a\", \"gin_unittests\": \"5c653c1f70249575268b35b3e4d1941e1af28491\", \"google_apis_unittests\": \"50708159026f74143109f2e95b0c2e4906cf19b5\", \"gpu_unittests\": \"e851ff8eef5de5ad58e473c7bd724b18d2cb3e21\", \"grit_python_unittests\": \"f228d7975fe1fa8e5512e444727a70881a83f8ff\", \"gwp_asan_unittests\": \"e6b984060ecac52f5f3fdd68785a5509be1087ca\", \"headless_browsertests\": \"9c82d3f46d4c08b4ef921d9f0c64daffb5292077\", \"headless_unittests\": \"a87c3fcdcc160ab1e63cb707ca315261573528c4\", \"interactive_ui_tests\": \"90e4381174f5fd9e62c03c1f4c23e85965181135\", \"ipc_tests\": \"c7ee8a6f5ae1f81ebe163a739ae1902b93e65e34\", \"jingle_unittests\": \"d58fd992de8c271d46adba818afdf3ec97835e08\", \"latency_unittests\": \"1d2ca4cee61491a038d17eef62b72c24cfff3104\", \"libjingle_xmpp_unittests\": \"44df380fec3ff65ab86aab12edf601d5ab9b3606\", \"media_blink_unittests\": \"b76bdf23bd3eaf987fce6e3475c68beaffb8fa15\", \"media_unittests\": \"44f44498c74e247beb29841dcec46e3df196e547\", \"message_center_unittests\": \"f0f1175f0da3fe494a8085885f01915392e14c76\", \"metrics_python_tests\": \"b176f82c850472ee9e767b97a1669b94bb2b2ad2\", \"midi_unittests\": \"41fcc21936e74c5004bfdc84fda6c86478fd7773\", \"mojo_core_unittests\": \"3ee81860b4197b8bd69ab4778fc32c3234962c67\", \"mojo_unittests\": \"9ab70afe0b5eafd8a3bc9603d27c512ec8b56e37\", \"nacl_helper_nonsfi_unittests\": \"5efe5cc74b93e72e88a0650fe3f71db63357b4b3\", \"nacl_loader_unittests\": \"4cee681fdb16dbacbf935ab5f7a931e0fd216fd0\", \"native_theme_unittests\": \"312964ce2e0b7983b47e11701012da66fe243ec0\", \"net_unittests\": \"ce31cc027fd21278f8f82d0060b3db4a1d86046b\", \"openscreen_unittests\": \"9a47f333435b9c59132463ab07cec26536548bff\", \"pdf_unittests\": \"191b789a184ecf33d22814a1d2e2f6fea03de921\", \"perfetto_unittests\": \"d0f8a5785713eb272c81a8fa8593c78259969ab4\", \"ppapi_unittests\": \"f72448fb496b7d16f391a876d7b8b300d0104956\", \"printing_unittests\": \"c74c1464d59d90b7085913d17ffec43cb4baa646\", \"remoting_unittests\": \"1ece6e4098d08f2763f97a7b178f77004fb66683\", \"sandbox_linux_unittests\": \"6cbe2c09584bd41c2417d7dd01c0c5b4a1e3d406\", \"service_manager_unittests\": \"98879d636a15d61da5689f428f5bcde1d938f398\", \"services_unittests\": \"d2e855f1f7497a82924be19fd222360046f5480c\", \"shell_dialogs_unittests\": \"797f132fc76ffbc84d14cf90cdbe786d3070535b\", \"skia_unittests\": \"fa0e2060033c86bb210b1c7a4fdf0dfd4a377101\", \"snapshot_unittests\": \"a5a6ca4d536b4dfdd47c289bc00628526a29db51\", \"sql_unittests\": \"84d3d7178e9b6de7563975224820c13bb78e65ca\", \"storage_unittests\": \"d2908fea6c5a903150375b4b359c4234e6b79357\", \"sync_integration_tests\": \"7d354efed909e6802e6fef3d4bcb8b71f37fb35e\", \"telemetry_gpu_unittests\": \"16378620ea737deab242c5edf77ef1ba6c387acb\", \"telemetry_perf_unittests\": \"d381c211ed493e8b90c684eb84bc929cb2fb4bd3\", \"telemetry_unittests\": \"d1067f09645d4a49513816c40d483ed2774d337a\", \"traffic_annotation_auditor_unittests\": \"22732cf4d3c5b43dcad8a9f5657ff94930f54e36\", \"ui_base_unittests\": \"085b69979e731e6c70658c4ec53818ea938d9f46\", \"ui_touch_selection_unittests\": \"7bea9a59d407423256663b7d031e04152887cefe\", \"unit_tests\": \"c0f41a266def53d2f0ed98e2f8e41c052055ce21\", \"url_unittests\": \"69d7ced57355385327f58d61a4c567dbf118a070\", \"views_perftests\": \"e58d4d18d3a011cfd59bd4c987b3ee56238d0376\", \"views_unittests\": \"0d96d389e39a421686a35cf076f56913dbc7dece\", \"viz_unittests\": \"dc17325fabd9fe78707971f9c0fc13294ac4076d\", \"vr_common_unittests\": \"f9ad4da9671edc0b258fd29acad59b3797e2ffe9\", \"vr_pixeltests\": \"fe1db68bd9b529940c25e32b4ca2321aff5203fa\", \"webdriver_wpt_tests\": \"daaf664d3d77aad4add3f1628029818eb070e11b\", \"weblayer_browsertests\": \"b1e80627fcc5ca840030ea061fe1b3fb3526db5a\", \"weblayer_unittests\": \"50e4831c179d939db7fb89b65096aadb62c3fa8e\", \"wm_unittests\": \"e675662f3406c543afa3e176ad53c135f298f5b2\", \"wtf_unittests\": \"69a87b0056460dc39f0cec6edb9c38d6426ddd17\", \"x11_unittests\": \"b8b385d8e305d2ae557d7fd8d354cfcc2ba2c973\", \"xr_browser_tests\": \"6ee4d86a669571aff4442b25c7595e49e5e4fe55\", \"zlib_unittests\": \"62fbc1e96f5344e4c54cb42138d061f2a7110ded\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-91-m395\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603660367735828",
"status": "COMPLETED",
"status_changed_ts": "1603664262001386",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177006",
"builder:Linux Builder (dbg)",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030866394014584288",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865436331741042336/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f7a4a0ca36b9710",
"user_agent:luci-scheduler"
],
"updated_ts": "1603664262007478",
"url": "https://ci.chromium.org/b/8865436331741042336",
"utcnow_ts": "1603664262540665"
}
}
[22:17:42.549] Invocation finished in 1h42m55.21020589s with status SUCCEEDED