[17:10:04.695] New invocation is queued and will start shortly
[17:10:08.485] Starting the invocation (attempt 1)
[17:10:08.526] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:10:08.527] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:10:08.527] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049632845361374816",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9049632845361374816",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"gitiles_ref:refs/heads/master"
]
}
[17:10:10.852] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585761008645237",
"id": "8884202780557616624",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585761010322620",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170496",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049632845361374816",
"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/8884202780557616624/+/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": "1585761010322788",
"url": "https://ci.chromium.org/b/8884202780557616624",
"utcnow_ts": "1585761010792884"
}
}
[17:10:10.852] Task URL: https://ci.chromium.org/b/8884202780557616624
[17:10:10.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:2:0) after 1m0s
[17:11:10.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:2:0)
[17:11:10.844] Timer tick, asking Buildbucket for the build status
[17:11:11.042] Build 8884202780557616624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:11.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:3:0) after 1m0s
[17:12:11.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:3:0)
[17:12:11.188] Timer tick, asking Buildbucket for the build status
[17:12:11.969] Build 8884202780557616624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:11.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:4:0) after 1m0s
[17:13:12.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:4:0)
[17:13:12.067] Timer tick, asking Buildbucket for the build status
[17:13:12.765] Build 8884202780557616624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:12.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:5:0) after 1m0s
[17:14:12.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:5:0)
[17:14:12.822] Timer tick, asking Buildbucket for the build status
[17:14:12.977] Build 8884202780557616624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:12.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:6:0) after 1m0s
[17:15:04.670] Received PubSub notification, asking Buildbucket for the build status
[17:15:04.781] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:13.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:6:0)
[17:15:13.014] Timer tick, asking Buildbucket for the build status
[17:15:13.195] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:13.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:8:0) after 1m0s
[17:16:13.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:8:0)
[17:16:13.265] Timer tick, asking Buildbucket for the build status
[17:16:13.419] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:13.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:9:0) after 1m0s
[17:17:13.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:9:0)
[17:17:13.491] Timer tick, asking Buildbucket for the build status
[17:17:13.614] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:13.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:10:0) after 1m0s
[17:18:13.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:10:0)
[17:18:13.644] Timer tick, asking Buildbucket for the build status
[17:18:13.722] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:13.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:11:0) after 1m0s
[17:19:13.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:11:0)
[17:19:13.782] Timer tick, asking Buildbucket for the build status
[17:19:13.929] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:13.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:12:0) after 1m0s
[17:20:14.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:12:0)
[17:20:14.004] Timer tick, asking Buildbucket for the build status
[17:20:14.188] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:14.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:13:0) after 1m0s
[17:21:14.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:13:0)
[17:21:14.247] Timer tick, asking Buildbucket for the build status
[17:21:14.426] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:14.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:14:0) after 1m0s
[17:22:14.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:14:0)
[17:22:14.453] Timer tick, asking Buildbucket for the build status
[17:22:14.602] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:14.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:15:0) after 1m0s
[17:23:14.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:15:0)
[17:23:14.803] Timer tick, asking Buildbucket for the build status
[17:23:14.982] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:14.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:16:0) after 1m0s
[17:24:15.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:16:0)
[17:24:15.003] Timer tick, asking Buildbucket for the build status
[17:24:15.169] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:15.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:17:0) after 1m0s
[17:25:15.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:17:0)
[17:25:15.227] Timer tick, asking Buildbucket for the build status
[17:25:16.015] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:16.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:18:0) after 1m0s
[17:26:16.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:18:0)
[17:26:16.091] Timer tick, asking Buildbucket for the build status
[17:26:16.245] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:16.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:19:0) after 1m0s
[17:27:16.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:19:0)
[17:27:16.344] Timer tick, asking Buildbucket for the build status
[17:27:16.718] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:16.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:20:0) after 1m0s
[17:28:16.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:20:0)
[17:28:16.753] Timer tick, asking Buildbucket for the build status
[17:28:17.723] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:17.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:21:0) after 1m0s
[17:29:17.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:21:0)
[17:29:17.778] Timer tick, asking Buildbucket for the build status
[17:29:17.968] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:17.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:22:0) after 1m0s
[17:30:18.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:22:0)
[17:30:18.028] Timer tick, asking Buildbucket for the build status
[17:30:18.224] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:18.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:23:0) after 1m0s
[17:31:18.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:23:0)
[17:31:18.333] Timer tick, asking Buildbucket for the build status
[17:31:18.482] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:24:0) after 1m0s
[17:32:18.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:24:0)
[17:32:18.553] Timer tick, asking Buildbucket for the build status
[17:32:18.792] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:25:0) after 1m0s
[17:33:18.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:25:0)
[17:33:18.797] Timer tick, asking Buildbucket for the build status
[17:33:19.226] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:19.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:26:0) after 1m0s
[17:34:19.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:26:0)
[17:34:19.381] Timer tick, asking Buildbucket for the build status
[17:34:21.354] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:21.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:27:0) after 1m0s
[17:35:21.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:27:0)
[17:35:21.402] Timer tick, asking Buildbucket for the build status
[17:35:21.875] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:21.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:28:0) after 1m0s
[17:36:22.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:28:0)
[17:36:22.007] Timer tick, asking Buildbucket for the build status
[17:36:22.375] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:22.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:29:0) after 1m0s
[17:37:22.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:29:0)
[17:37:22.444] Timer tick, asking Buildbucket for the build status
[17:37:22.682] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:22.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:30:0) after 1m0s
[17:38:22.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:30:0)
[17:38:22.721] Timer tick, asking Buildbucket for the build status
[17:38:23.859] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:23.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:31:0) after 1m0s
[17:39:23.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:31:0)
[17:39:23.883] Timer tick, asking Buildbucket for the build status
[17:39:24.019] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:32:0) after 1m0s
[17:40:24.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:32:0)
[17:40:24.051] Timer tick, asking Buildbucket for the build status
[17:40:24.262] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:24.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:33:0) after 1m0s
[17:41:24.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:33:0)
[17:41:24.299] Timer tick, asking Buildbucket for the build status
[17:41:24.597] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:24.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:34:0) after 1m0s
[17:42:24.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:34:0)
[17:42:24.668] Timer tick, asking Buildbucket for the build status
[17:42:25.461] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:25.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:35:0) after 1m0s
[17:43:25.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:35:0)
[17:43:25.553] Timer tick, asking Buildbucket for the build status
[17:43:26.035] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:26.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:36:0) after 1m0s
[17:44:26.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:36:0)
[17:44:26.071] Timer tick, asking Buildbucket for the build status
[17:44:26.239] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:37:0) after 1m0s
[17:45:26.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:37:0)
[17:45:26.306] Timer tick, asking Buildbucket for the build status
[17:45:26.437] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:26.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:38:0) after 1m0s
[17:46:26.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:38:0)
[17:46:26.599] Timer tick, asking Buildbucket for the build status
[17:46:26.747] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:39:0) after 1m0s
[17:47:26.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:39:0)
[17:47:26.914] Timer tick, asking Buildbucket for the build status
[17:47:27.108] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:27.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:40:0) after 1m0s
[17:48:27.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:40:0)
[17:48:27.242] Timer tick, asking Buildbucket for the build status
[17:48:27.706] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:27.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:41:0) after 1m0s
[17:49:27.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:41:0)
[17:49:27.906] Timer tick, asking Buildbucket for the build status
[17:49:28.159] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:28.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:42:0) after 1m0s
[17:50:28.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:42:0)
[17:50:28.344] Timer tick, asking Buildbucket for the build status
[17:50:28.862] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:28.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:43:0) after 1m0s
[17:51:28.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:43:0)
[17:51:28.914] Timer tick, asking Buildbucket for the build status
[17:51:29.404] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:29.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:44:0) after 1m0s
[17:52:29.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:44:0)
[17:52:29.455] Timer tick, asking Buildbucket for the build status
[17:52:29.864] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:29.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:45:0) after 1m0s
[17:53:29.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:45:0)
[17:53:29.928] Timer tick, asking Buildbucket for the build status
[17:53:30.305] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:30.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:46:0) after 1m0s
[17:54:30.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:46:0)
[17:54:30.370] Timer tick, asking Buildbucket for the build status
[17:54:30.568] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:30.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:47:0) after 1m0s
[17:55:30.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:47:0)
[17:55:30.572] Timer tick, asking Buildbucket for the build status
[17:55:31.893] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:31.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:48:0) after 1m0s
[17:56:31.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:48:0)
[17:56:31.880] Timer tick, asking Buildbucket for the build status
[17:56:32.029] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:32.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:49:0) after 1m0s
[17:57:32.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:49:0)
[17:57:32.151] Timer tick, asking Buildbucket for the build status
[17:57:32.352] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:32.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:50:0) after 1m0s
[17:58:32.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:50:0)
[17:58:32.377] Timer tick, asking Buildbucket for the build status
[17:58:32.551] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:32.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:51:0) after 1m0s
[17:59:32.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:51:0)
[17:59:32.996] Timer tick, asking Buildbucket for the build status
[17:59:33.158] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:33.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:52:0) after 1m0s
[18:00:33.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:52:0)
[18:00:33.428] Timer tick, asking Buildbucket for the build status
[18:00:33.819] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:33.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:53:0) after 1m0s
[18:01:34.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:53:0)
[18:01:34.758] Timer tick, asking Buildbucket for the build status
[18:01:34.911] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:34.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:54:0) after 1m0s
[18:02:35.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:54:0)
[18:02:35.226] Timer tick, asking Buildbucket for the build status
[18:02:35.428] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:35.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:55:0) after 1m0s
[18:03:35.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:55:0)
[18:03:35.563] Timer tick, asking Buildbucket for the build status
[18:03:36.063] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:36.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:56:0) after 1m0s
[18:04:36.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:56:0)
[18:04:36.199] Timer tick, asking Buildbucket for the build status
[18:04:36.572] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:36.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:57:0) after 1m0s
[18:05:36.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:57:0)
[18:05:36.717] Timer tick, asking Buildbucket for the build status
[18:05:37.499] Build 8884202780557616624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:37.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049632845361374816:58:0) after 1m0s
[18:05:54.072] Received PubSub notification, asking Buildbucket for the build status
[18:05:54.154] Build 8884202780557616624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:05:54.154] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585764353158402",
"created_by": "project:chromium",
"created_ts": "1585761008645237",
"id": "8884202780557616624",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"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-central1-b-8-8-v5ns\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170496, \"got_angle_revision\": \"38df4ab618072b262bd59fdfc05dce873e9b0a49\", \"got_dawn_revision\": \"a0afd3158504f5ae0cd4aeced0b21a5f66635729\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c\", \"got_revision_cp\": \"refs/heads/master@{#755399}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"5cf1e9a31c90ccd9ec40d0c5ef1357f6e0ec1cfd\", \"got_v8_revision\": \"05530618c6b37f9d517e1f3ee5c90a7e40edcdfa\", \"got_v8_revision_cp\": \"refs/heads/8.3.119@{#1}\", \"got_webrtc_revision\": \"e283d1ca64c61cb5fa7fce1bcb2cb5fdc067f103\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30959}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c\", \"swarm_hashes_refs/heads/master(at){#755399}_without_patch\": {\"accessibility_unittests\": \"3fdd38ca083600861d03c641fd522a1ad21d7789\", \"angle_unittests\": \"8527122ee550c1cbfda4446161e3aac61c87f14a\", \"app_shell_unittests\": \"e42d31613876156f01f35d9dc1781bd8798fda4f\", \"aura_unittests\": \"b9550ac1ce7e1470f230234fd7de46c7909a5f6d\", \"base_unittests\": \"a3ab1cda6d9855638cb3a27367906c02484758f4\", \"base_util_unittests\": \"064abcd23d791775ee2bbf9d32a1cda8cc91c3dc\", \"blink_common_unittests\": \"17ad39c497e9d4d057264a4b527716a416935493\", \"blink_fuzzer_unittests\": \"9948c6dc14ff4aef990cae25881e944ff05a592a\", \"blink_heap_unittests\": \"f81bb818b68c7984d65ba7385337a1caa5ee225c\", \"blink_platform_unittests\": \"6f98867604c87512db871f89ed81abc8793cc018\", \"blink_python_tests\": \"e07ce8cb82c00d53381506a79f0a4e53cf6ec059\", \"blink_unittests\": \"08704226f2038d33c7b03400bb700d80dcc31493\", \"blink_web_tests\": \"2dfb4e687a158e4c9592c1a7a0f1164d770189a4\", \"boringssl_crypto_tests\": \"b53ef80a7ced43800b34c942aca1059889b35fcc\", \"boringssl_ssl_tests\": \"6a56744374c748562234cfa1750fd131ad2607ec\", \"browser_tests\": \"fd788b1b07a2e183dfa297ac8988afe32b690354\", \"cacheinvalidation_unittests\": \"2a06e20316d5a1fd57115fff692d8ba3d8655937\", \"capture_unittests\": \"3661416bba30e291abc61b4ffcfe9e462816edd9\", \"cast_unittests\": \"03d35ca408d11d89d838e0a6c7a596dd207a232e\", \"cc_unittests\": \"66894af6ac3e82c4f3967a206ac1a3a3ccf223aa\", \"chrome_app_unittests\": \"daa2ff472ad6097322322476bb9c9158c80da37c\", \"chromedriver_unittests\": \"e76a6a0f979d6331aa78d522ea83f288f2d6eeba\", \"components_browsertests\": \"e0f5ec6171cc3b8d158a3f6e9bf8f65e8ae0cc87\", \"components_unittests\": \"af089c95b9b0fce9467a937c5a622929a8903df3\", \"compositor_unittests\": \"fb8d1dc93b8ad71b95c09625917590f1f35f7a22\", \"content_browsertests\": \"d0ccfae5321b53b0335ceb0695e11b3705fae67c\", \"content_shell_crash_test\": \"9fba74e9e306799337f9e12bc80c5452931ad737\", \"content_unittests\": \"6ca053e974d2d776b87820529d916934cafc3bd9\", \"crashpad_tests\": \"6a11c237295a4f5a822edb1149de5c23b2d41d5d\", \"cronet_tests\": \"86957b3fa1eacf06bc2ddfe10af3cea8889d5ca6\", \"cronet_unittests\": \"52f624d71e396f6e8feb0994dd01302408921eca\", \"crypto_unittests\": \"59dc6631527404166d8f7e3b0055c13b7ee9ba0e\", \"dbus_unittests\": \"bc626c42aa8b79f69b80a684212b331475e4536d\", \"device_unittests\": \"160d65544b8c28af9bdfbb836ce66a851f0caa43\", \"display_unittests\": \"fee7a182d5727166ba26f87a2c254d9fe651e4b2\", \"events_unittests\": \"ac1905045d133f7529baa618c5605fa1de749f4d\", \"extensions_browsertests\": \"3e476410fda50ca7c75155a2b327964fc523d7f0\", \"extensions_unittests\": \"9402552e6ae72d14ca5c17e5f129f88940728d9f\", \"filesystem_service_unittests\": \"5f23204f85c263e93faa1923ba60082b72cb9b31\", \"flatbuffers_unittests\": \"72ac4f314db80fab790f3135fe10fde26e7da08e\", \"gcm_unit_tests\": \"2b5b2273eb926ae5dd319bba923a2e3e7c03a065\", \"gfx_unittests\": \"3330dfe94ac2b8197022a7e95d0532ce2adf5681\", \"gin_unittests\": \"d18f49a737fa4ed5b33c4a864387239ebda94474\", \"google_apis_unittests\": \"4dfdea140ac1da1e965eec1041fdbd2ae46029ae\", \"gpu_unittests\": \"36f89377db8f4fb6b17c3b5b3430fc0d8620dd90\", \"grit_python_unittests\": \"8c3aba08684a4851b7eb5e55316c1cdda2ef1701\", \"gwp_asan_unittests\": \"73e856c4c4e972512fcd2fee04dbbea2cc9ac227\", \"headless_browsertests\": \"471a2c35adaa025657a5628f2660e18ea7e48938\", \"headless_unittests\": \"0dcfc8b4669a9955597fb3d467b41d120c55deea\", \"interactive_ui_tests\": \"560be7cba5e0f51e838f5efa0a06454a69a248f6\", \"ipc_tests\": \"bf7cb9c083f18ec5c44ad954dae212b6ef2e57e0\", \"jingle_unittests\": \"80396a7d2974cf8038bf965720a071c95039fd93\", \"latency_unittests\": \"026e66cee2626838a5e4ca23e958b5e666e52ab4\", \"libjingle_xmpp_unittests\": \"da199b1e53fe896c1a655a297332509ad7e041bf\", \"media_blink_unittests\": \"151d0c07a55bf98e99f24f48c25a9a2251f1410b\", \"media_unittests\": \"c10c2d8221d1d4ed7abaa0170309cb4c3617056b\", \"message_center_unittests\": \"bed732bc1f0eca6fd70f5b0d8701adc4af9f449c\", \"metrics_python_tests\": \"7b95438d1c7dea2a41f5e7a858028bc26b8ecda1\", \"midi_unittests\": \"7391b7d03f75d27bd61e15b9630ecab01be7ad1d\", \"mojo_core_unittests\": \"a213d1e46de01cb4ea71225002d7e2905379216d\", \"mojo_unittests\": \"0bc13dd8fed560757168331a74523a1cee725ae8\", \"nacl_helper_nonsfi_unittests\": \"5f2c609da47e1006c5639a67fb5d8210763e47ed\", \"nacl_loader_unittests\": \"a7ebd4b7c8fca51d543fe621003905c59f0a9daa\", \"native_theme_unittests\": \"2a9d36a30de3c38672161d46ebf4b6cf06723b69\", \"net_unittests\": \"736321f15d374596ade32a9f2ecfac276ceaf214\", \"pdf_unittests\": \"254fcbb40a8afea5bf0e48ed533563c0934937a6\", \"perfetto_unittests\": \"852b1680e63076f5cdb27e36053ced47572fbe53\", \"ppapi_unittests\": \"e1ad5d73b1cb9e905c32af3a2c83c00b319f11d5\", \"printing_unittests\": \"a0f8d4f5616e5c1cb3987468b2dda257af92bd29\", \"remoting_unittests\": \"f9cdb35b10a57efd555052b78d6ddb59cb759d9e\", \"sandbox_linux_unittests\": \"fc24d6748c18a78e760832cf27477970fcb11035\", \"service_manager_unittests\": \"454076ead675b81e882fb09390c914cd1f406cc5\", \"services_unittests\": \"730fb8d3191c5c89a36fee286b3ee5886a55e0a4\", \"shell_dialogs_unittests\": \"aca99355457e522a512c7e52963c023c8860750e\", \"skia_unittests\": \"0da3c9c9477542d9301f60a9af359f71ad7719b6\", \"snapshot_unittests\": \"d5cdc5841ebf839b36ad2ca328537899f5990dd4\", \"sql_unittests\": \"18dbb1e4fb600b42d5720ff539298e8abcf08053\", \"storage_unittests\": \"d98488781efa8a25b59c2fd63808c844e0a5a334\", \"sync_integration_tests\": \"0f0869c3ba694dc512764a9c750b1289ce9e3544\", \"telemetry_gpu_unittests\": \"d406c2dea2e2f99fddb3473a9d2ae7283d88de10\", \"telemetry_perf_unittests\": \"75359c5b3d6aa9cfabdfc1071aa57eed08ce5cb3\", \"telemetry_unittests\": \"9de4e451940c1448c33e5314af00d1e89bf5d885\", \"traffic_annotation_auditor_unittests\": \"32c4021b8cd9cc5fcedb1b1176d5972555dd89d4\", \"ui_base_unittests\": \"26ba0a97c6111a0dad0cc024465ee7d8848a57e0\", \"ui_touch_selection_unittests\": \"b12f971f5afaca8b42b07e16c028a35b0a64cc2b\", \"unit_tests\": \"9214fdb9e75b39b5b3d3b65c95ec9792edeec228\", \"url_unittests\": \"b8898750dd1716d4b182dd10e5717cb7279e3716\", \"views_perftests\": \"585b24be54807b70d119543c49d6bb76e0179381\", \"views_unittests\": \"3b60f703a4151c4e59ab611d4d697bada7c95a7e\", \"viz_unittests\": \"816de85245707f43a2338982c10d19c75e18e4a1\", \"vr_common_unittests\": \"2f5c6a6e10086aa13fb43b8208c3b4a2863b243a\", \"vr_pixeltests\": \"5c780f9540bbb35613f0013fb159de353f2112ee\", \"webdriver_wpt_tests\": \"125e546e979f262244f674fd5af6b0fad5c74bf3\", \"weblayer_browsertests\": \"e8fe8f051b94c30dd3f8662f39eb24d4a56b27d0\", \"wm_unittests\": \"298ec3ac5dbc8f48cab2d1d9ac7e4cc2592ba0d0\", \"wtf_unittests\": \"0d41ea0952df9c2d4c94cce85c9b29c0f9f5f464\", \"xr_browser_tests\": \"6dfddc55487d901fe75309c3f585ddf9a357d11c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_d94bc43a1bd6073c4720097d771b0eb8c5098b1a53a2f9884a7e1b0af643c636_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-8-v5ns\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"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\": [\"4916-b2318d4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585761302782036",
"status": "COMPLETED",
"status_changed_ts": "1585764353548010",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170496",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae1fc6847650b3dc2d4fcdb83e1a086a5282c58c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049632845361374816",
"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/8884202780557616624/+/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:4b4f8a4cd861ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585764353553609",
"url": "https://ci.chromium.org/b/8884202780557616624",
"utcnow_ts": "1585764354144844"
}
}
[18:05:54.155] Invocation finished in 55m49.475087984s with status SUCCEEDED