[08:13:23.151] New invocation is queued and will start shortly
[08:13:24.324] Starting the invocation (attempt 1)
[08:13:24.447] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:13:24.447] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:13:24.447] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057820338105359360",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f125fd31ec63facf1d57ec5cfb4f779c37a14367\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9057820338105359360",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"gitiles_ref:refs/heads/master"
]
}
[08:13:25.699] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577952805002115",
"id": "8892390275500893824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f125fd31ec63facf1d57ec5cfb4f779c37a14367\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577952805516169",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166849",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057820338105359360",
"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/8892390275500893824/+/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": "1577952805516316",
"url": "https://ci.chromium.org/b/8892390275500893824",
"utcnow_ts": "1577952805690115"
}
}
[08:13:25.699] Task URL: https://ci.chromium.org/b/8892390275500893824
[08:13:25.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:2:0) after 1m0s
[08:14:26.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:2:0)
[08:14:26.008] Timer tick, asking Buildbucket for the build status
[08:14:27.214] Build 8892390275500893824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:27.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:3:0) after 1m0s
[08:15:27.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:3:0)
[08:15:27.525] Timer tick, asking Buildbucket for the build status
[08:15:27.880] Build 8892390275500893824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:27.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:4:0) after 1m0s
[08:16:28.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:4:0)
[08:16:28.094] Timer tick, asking Buildbucket for the build status
[08:16:28.262] Build 8892390275500893824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:28.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:5:0) after 1m0s
[08:17:28.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:5:0)
[08:17:28.351] Timer tick, asking Buildbucket for the build status
[08:17:28.698] Build 8892390275500893824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:28.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:6:0) after 1m0s
[08:18:03.767] Received PubSub notification, asking Buildbucket for the build status
[08:18:03.931] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:29.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:6:0)
[08:18:29.032] Timer tick, asking Buildbucket for the build status
[08:18:29.744] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:29.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:8:0) after 1m0s
[08:19:29.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:8:0)
[08:19:29.858] Timer tick, asking Buildbucket for the build status
[08:19:30.606] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:30.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:9:0) after 1m0s
[08:20:30.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:9:0)
[08:20:30.625] Timer tick, asking Buildbucket for the build status
[08:20:30.829] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:30.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:10:0) after 1m0s
[08:21:30.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:10:0)
[08:21:30.852] Timer tick, asking Buildbucket for the build status
[08:21:32.139] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:11:0) after 1m0s
[08:22:32.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:11:0)
[08:22:32.224] Timer tick, asking Buildbucket for the build status
[08:22:32.552] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:32.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:12:0) after 1m0s
[08:23:32.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:12:0)
[08:23:32.748] Timer tick, asking Buildbucket for the build status
[08:23:32.974] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:32.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:13:0) after 1m0s
[08:24:33.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:13:0)
[08:24:33.265] Timer tick, asking Buildbucket for the build status
[08:24:33.694] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:33.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:14:0) after 1m0s
[08:25:33.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:14:0)
[08:25:33.890] Timer tick, asking Buildbucket for the build status
[08:25:34.335] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:34.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:15:0) after 1m0s
[08:26:34.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:15:0)
[08:26:34.440] Timer tick, asking Buildbucket for the build status
[08:26:34.876] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:34.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:16:0) after 1m0s
[08:27:35.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:16:0)
[08:27:35.038] Timer tick, asking Buildbucket for the build status
[08:27:35.263] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:35.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:17:0) after 1m0s
[08:28:35.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:17:0)
[08:28:35.294] Timer tick, asking Buildbucket for the build status
[08:28:35.540] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:35.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:18:0) after 1m0s
[08:29:35.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:18:0)
[08:29:35.714] Timer tick, asking Buildbucket for the build status
[08:29:36.729] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:19:0) after 1m0s
[08:30:36.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:19:0)
[08:30:36.739] Timer tick, asking Buildbucket for the build status
[08:30:36.916] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:36.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:20:0) after 1m0s
[08:31:36.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:20:0)
[08:31:36.934] Timer tick, asking Buildbucket for the build status
[08:31:37.183] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:37.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:21:0) after 1m0s
[08:32:37.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:21:0)
[08:32:37.204] Timer tick, asking Buildbucket for the build status
[08:32:37.591] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:37.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:22:0) after 1m0s
[08:33:37.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:22:0)
[08:33:37.607] Timer tick, asking Buildbucket for the build status
[08:33:39.510] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:39.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:23:0) after 1m0s
[08:34:39.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:23:0)
[08:34:39.528] Timer tick, asking Buildbucket for the build status
[08:34:39.983] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:24:0) after 1m0s
[08:35:40.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:24:0)
[08:35:40.001] Timer tick, asking Buildbucket for the build status
[08:35:40.577] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:40.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:25:0) after 1m0s
[08:36:40.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:25:0)
[08:36:40.582] Timer tick, asking Buildbucket for the build status
[08:36:41.285] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:41.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:26:0) after 1m0s
[08:37:41.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:26:0)
[08:37:41.285] Timer tick, asking Buildbucket for the build status
[08:37:41.459] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:41.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:27:0) after 1m0s
[08:38:41.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:27:0)
[08:38:41.488] Timer tick, asking Buildbucket for the build status
[08:38:41.628] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:28:0) after 1m0s
[08:39:41.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:28:0)
[08:39:41.705] Timer tick, asking Buildbucket for the build status
[08:39:42.441] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:42.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:29:0) after 1m0s
[08:40:42.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:29:0)
[08:40:42.485] Timer tick, asking Buildbucket for the build status
[08:40:43.017] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:43.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:30:0) after 1m0s
[08:41:43.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:30:0)
[08:41:43.040] Timer tick, asking Buildbucket for the build status
[08:41:43.259] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:43.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:31:0) after 1m0s
[08:42:43.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:31:0)
[08:42:43.324] Timer tick, asking Buildbucket for the build status
[08:42:43.458] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:43.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:32:0) after 1m0s
[08:43:43.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:32:0)
[08:43:43.481] Timer tick, asking Buildbucket for the build status
[08:43:43.673] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:43.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:33:0) after 1m0s
[08:44:43.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:33:0)
[08:44:43.714] Timer tick, asking Buildbucket for the build status
[08:44:43.917] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:43.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:34:0) after 1m0s
[08:45:43.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:34:0)
[08:45:43.937] Timer tick, asking Buildbucket for the build status
[08:45:44.624] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:44.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:35:0) after 1m0s
[08:46:44.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:35:0)
[08:46:44.601] Timer tick, asking Buildbucket for the build status
[08:46:44.789] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:44.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:36:0) after 1m0s
[08:47:44.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:36:0)
[08:47:44.806] Timer tick, asking Buildbucket for the build status
[08:47:45.044] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:45.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:37:0) after 1m0s
[08:48:45.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:37:0)
[08:48:45.115] Timer tick, asking Buildbucket for the build status
[08:48:45.538] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:45.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:38:0) after 1m0s
[08:49:45.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:38:0)
[08:49:45.674] Timer tick, asking Buildbucket for the build status
[08:49:46.015] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:46.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:39:0) after 1m0s
[08:50:46.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:39:0)
[08:50:46.089] Timer tick, asking Buildbucket for the build status
[08:50:46.395] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:40:0) after 1m0s
[08:51:46.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:40:0)
[08:51:46.441] Timer tick, asking Buildbucket for the build status
[08:51:47.787] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:47.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:41:0) after 1m0s
[08:52:48.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:41:0)
[08:52:48.028] Timer tick, asking Buildbucket for the build status
[08:52:50.615] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:50.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:42:0) after 1m0s
[08:53:50.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:42:0)
[08:53:50.624] Timer tick, asking Buildbucket for the build status
[08:53:51.608] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:51.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:43:0) after 1m0s
[08:54:51.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:43:0)
[08:54:51.625] Timer tick, asking Buildbucket for the build status
[08:54:51.821] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:44:0) after 1m0s
[08:55:52.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:44:0)
[08:55:52.194] Timer tick, asking Buildbucket for the build status
[08:55:52.481] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:52.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:45:0) after 1m0s
[08:56:52.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:45:0)
[08:56:52.724] Timer tick, asking Buildbucket for the build status
[08:56:52.922] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:52.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:46:0) after 1m0s
[08:57:53.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:46:0)
[08:57:53.407] Timer tick, asking Buildbucket for the build status
[08:57:53.732] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:53.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:47:0) after 1m0s
[08:58:54.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:47:0)
[08:58:54.004] Timer tick, asking Buildbucket for the build status
[08:58:54.230] Build 8892390275500893824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057820338105359360:48:0) after 1m0s
[08:59:31.814] Received PubSub notification, asking Buildbucket for the build status
[08:59:32.333] Build 8892390275500893824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:59:32.333] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577955571087462",
"created_by": "project:chromium",
"created_ts": "1577952805002115",
"id": "8892390275500893824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f125fd31ec63facf1d57ec5cfb4f779c37a14367\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-east1-d-8-86-7nrk\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166849, \"got_angle_revision\": \"cbbfa2f28a0ee0ca652416d74b42c58238b24a3a\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f125fd31ec63facf1d57ec5cfb4f779c37a14367\", \"got_revision_cp\": \"refs/heads/master@{#727951}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"10a900e5ffaffdffe2806b1507af43a74acdfe9e\", \"got_v8_revision\": \"2844b390cb9077f2d9e46c949f908d677cde5ea1\", \"got_v8_revision_cp\": \"refs/heads/8.1.82@{#1}\", \"got_webrtc_revision\": \"a43777dead46df4575a58c5ca2733c5f3ff0212b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30130}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f125fd31ec63facf1d57ec5cfb4f779c37a14367\", \"swarm_hashes_refs/heads/master(at){#727951}_without_patch\": {\"accessibility_unittests\": \"633c59f67773703adfe8f439d784e0f807300a48\", \"angle_unittests\": \"651af4a828bf1e70b18433360e6c1697bd302003\", \"app_shell_unittests\": \"44d7529cd1262e403a7f40b923b3f12503a6c211\", \"aura_unittests\": \"4388647dd807c02cde70ec94ed5f24adab50b5a8\", \"base_unittests\": \"ad9b88fa9e92e893fc23eb54476744582c362491\", \"base_util_unittests\": \"24387c1fab42f1c630997865760d290bafae0b00\", \"blink_common_unittests\": \"7fe5a30838c591441002a242834ff0f609912b98\", \"blink_fuzzer_unittests\": \"5107cb0d7abcf080185728b56d027ca5c6b84086\", \"blink_heap_unittests\": \"ec39a6dc30448bad72e0e02e740eebe5eeea08f6\", \"blink_platform_unittests\": \"42f937af2cfb49196b056ba0396ee0e7425023ce\", \"blink_python_tests\": \"c4ab56df4a117a3dcf8cfcb9243a26ab6fd91766\", \"blink_unittests\": \"acdf304f5fa832c9f6914a9c8a6915d84b25dbc5\", \"blink_web_tests\": \"991f88806d5fac80a40f69b1c71d8a50620e752b\", \"boringssl_crypto_tests\": \"5b09f3f72503d660879c9b112d0d03ae8a57000a\", \"boringssl_ssl_tests\": \"adea84f9a1f69c6255cd4377dd879e2bbb3488b2\", \"browser_tests\": \"67b6c1f1cb0490eb1d2b9a3e5d30d40a1b6f07ae\", \"cacheinvalidation_unittests\": \"e4aefa25d6e815aa762deecbf185ff1c18567091\", \"capture_unittests\": \"409caa8232a915d5d1d47169e07a5edc897f8b31\", \"cast_unittests\": \"c96e64641f20540ea0a8ab81f067fcef2b76efaa\", \"cc_unittests\": \"942bbf12a2023f71c12dbe56112c7569680eefff\", \"chrome_app_unittests\": \"9fee32d6986c3911739c5620fa5a1a2a9aa62e43\", \"chromedriver_unittests\": \"f1b688c91064163805a01e0bb2561f38679bd12e\", \"components_browsertests\": \"12c40c2dadba65028df6242da8a6b8c93225ab3a\", \"components_unittests\": \"5b62c186e97f4c9257de873b721e39ac66f6b903\", \"compositor_unittests\": \"8c04153c826e0cd72fa07b24d7885eed94d4d842\", \"content_browsertests\": \"ba1ecef3a6ae76c4a36c918468ab5e903d19369e\", \"content_shell_crash_test\": \"397eb26d1cc97fb7a673d44e1bbc4f22afc670e7\", \"content_unittests\": \"ad6f19407702cbded0a2236569950dc2a717ef18\", \"crashpad_tests\": \"ced2b5096a9cf070175658f402457a761dbc0355\", \"cronet_tests\": \"043173e42db90c5c70bf74c5920cffae38617a22\", \"cronet_unittests\": \"37648059b38a2e83f5dfcd7a2299c963854b8d09\", \"crypto_unittests\": \"489b9939fd909395f44e1e6ecc6480735be70cfa\", \"dbus_unittests\": \"f138aa8ab1db400335d2f805d34a998124a843e2\", \"device_unittests\": \"43d071ca7ab2705c677a80b64988c710df5c7506\", \"devtools_lint_check\": \"f8d29bf122a8878a796e78f5361295a01b244974\", \"devtools_type_check\": \"41a2684647e023acca4fd75576add11706776175\", \"display_unittests\": \"b69168f5c5e3d33e7f19ded73e0d6c206d86f753\", \"events_unittests\": \"23c575a8afa3b4b3a5451ac9a44a7b7f726a94e3\", \"extensions_browsertests\": \"f8f46ed24c3373fe433c7c0d18d04fa484f34542\", \"extensions_unittests\": \"ff3b6606c98695a7d93012d65c27328b3d7cbacc\", \"filesystem_service_unittests\": \"1b6fd2c53687f8efa9f9b7ccb362bfa52564c8eb\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"639e3f20194332cf146e75e6d41f1fc1f79d714c\", \"gfx_unittests\": \"612ad0a81bbe45db856e1ca02a6e6725bc895604\", \"gin_unittests\": \"dcdb9531edccd6e1cb0a9727343373c3b09920d1\", \"google_apis_unittests\": \"fe7941d21098e6ad2f4d1a67b1ce11b88c7796d3\", \"gpu_unittests\": \"dad1251ed73019b9c2cb52319f4b48d8f6161557\", \"grit_python_unittests\": \"c651860184eae0fccc98981c3c79be6f65eaf3fe\", \"gwp_asan_unittests\": \"e192982a5ef67d79183e2168378c395a8de83760\", \"headless_browsertests\": \"6d00b63170f6dad899bb16cf75815f14fd02b7df\", \"headless_unittests\": \"5327a2867326d0ad5573cdf8eed0035c6de4bd78\", \"interactive_ui_tests\": \"0644bc42ad8bc585304a3b1298bbaebb983e01f0\", \"ipc_tests\": \"fc5518a03b6ad32761942693794dc69d4bbe0878\", \"jingle_unittests\": \"08713380f8b486e5f682acdee9f5bd06c793750c\", \"latency_unittests\": \"0430eab9ab61b9c8c3f84ed83de8cff2b43f4bed\", \"libjingle_xmpp_unittests\": \"e1a7992bf263216510d2e91433ca172baae2e1a6\", \"media_blink_unittests\": \"2b362f79f76adaee9861b1c8fff756132eaeec0d\", \"media_service_unittests\": \"184a623943f3c36f906dff04f151da598e23020f\", \"media_unittests\": \"c69d39d237975c6cdd040d4685d60a528fea85ab\", \"message_center_unittests\": \"682b4e31e8f9ac334d3696eeae60fef14a011590\", \"metrics_python_tests\": \"d85db5c0e93dcf4f66a7cfe464526896fe229f60\", \"midi_unittests\": \"521031407f9d16dccc15c726add4fddb52a11d3a\", \"mojo_core_unittests\": \"e912be8b2338572f412cbec97b60b1e713b03af8\", \"mojo_unittests\": \"36b32b4ccd09fae41326e88db8bc1d950c3a7d4d\", \"nacl_helper_nonsfi_unittests\": \"0ab92f0146ce0c5adf34a610607e0de60a4b2683\", \"nacl_loader_unittests\": \"cacea151c8d950776ec8aecfe8adf654e54e55a8\", \"native_theme_unittests\": \"b0176463c1feba9e9b41ada91ba1e6c7826e54cc\", \"net_unittests\": \"8e3e1b234625457512382f2ab40e1a2d6c21e5dd\", \"pdf_unittests\": \"695201732204e34ca7b1958f67af13eedd787c24\", \"perfetto_unittests\": \"73867f6af7cedb3fb50bbf18b184f0cd3b72415b\", \"ppapi_unittests\": \"0f87611e3563907b94119de5ed714c047bf2a933\", \"printing_unittests\": \"e7e8050bef2194b8ba4bb41ffc1f82319b00aacd\", \"remoting_unittests\": \"a2ac29e538a554c8370a4882d3cbe651203723de\", \"sandbox_linux_unittests\": \"064c891a350059a4ca8a609adef64df07e051ad0\", \"service_manager_unittests\": \"a0e0ddc66fca38fa707929f4d206cddf40569a66\", \"services_unittests\": \"47effc82a6aefc09df4853f94264366d98474c63\", \"shell_dialogs_unittests\": \"665da798209ad72f5717bb0c6c1705882ac4a64b\", \"skia_unittests\": \"3ec6282c9c63b1fdb385fcd89a970a7370aef6a2\", \"snapshot_unittests\": \"f2bda4bcb458072f40ea3d15ea1ee5d48e58e902\", \"sql_unittests\": \"711c6f6132d635285e32bc2c10f7d50119b839d8\", \"storage_unittests\": \"d4c1a122502d350bc0435231b791cc779dee16b1\", \"sync_integration_tests\": \"5c74acc1df146256942a1630b3766c86d8f05ad6\", \"telemetry_gpu_unittests\": \"8c1cfed7cfd4754da36f31655114f0f389a0ae8a\", \"telemetry_perf_unittests\": \"829346317cc4c1d5494041de96d858e525ea6735\", \"telemetry_unittests\": \"43e0d24ea56add04779ec83e57439826843cc9a3\", \"traffic_annotation_auditor_unittests\": \"1bf104b716e9ebf5c57d31e34d6081926b33552b\", \"ui_base_unittests\": \"d28f9f398c707308d35f6b75f83ca8641ecf2412\", \"ui_touch_selection_unittests\": \"9abfa02c714cd8c1d92dbe560669af8865efd7c6\", \"unit_tests\": \"e147b9e3d8dea69a64f71a0a7bb201302c53b017\", \"url_unittests\": \"5a5396745deb84882253dd6d474e52f9a53b084b\", \"views_perftests\": \"4c7b0e7960f5b43fc535b666fb87b0a1882456b5\", \"views_unittests\": \"291ce71694f505e693b3d69bb08f8ef947523a75\", \"viz_unittests\": \"cba45fa685c49510ab85684c9920cfd8c30c4ec0\", \"vr_common_unittests\": \"cbb4aeb39d16243d818f0b5d1c14c7ac61b33d55\", \"vr_pixeltests\": \"fadf62b1c5e14522471771d8c5577faea45993b7\", \"webdriver_wpt_tests\": \"c11d6b2b08ebe37a768783d2bab3f135673ebc50\", \"weblayer_browsertests\": \"73e4fdc9cc1c527465218bdc47f1ef1ab9449c88\", \"wm_unittests\": \"c8af9e8d76f2a34268cb4ad883ec81792b5003dd\", \"wtf_unittests\": \"ae863d06012714e469279cd0932c19f6d2077cef\", \"xr_browser_tests\": \"195c5ed82344694f22d649bfe1ae93c122107ecf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-86-7nrk\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577953082683821",
"status": "COMPLETED",
"status_changed_ts": "1577955571433398",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166849",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f125fd31ec63facf1d57ec5cfb4f779c37a14367",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057820338105359360",
"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/8892390275500893824/+/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:497e228c0e3bb510",
"user_agent:luci-scheduler"
],
"updated_ts": "1577955571437004",
"url": "https://ci.chromium.org/b/8892390275500893824",
"utcnow_ts": "1577955572321335"
}
}
[08:59:32.333] Invocation finished in 46m9.199052772s with status SUCCEEDED