[13:30:10.483] New invocation is queued and will start shortly
[13:30:11.926] Starting the invocation (attempt 1)
[13:30:12.032] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:30:12.032] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:30:12.032] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053995334888462944",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1b704a240c1dbc25ec8bbe82f71e8fb3c447af99\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053995334888462944",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"gitiles_ref:refs/heads/master"
]
}
[13:30:12.863] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581600612258502",
"id": "8888565272358912192",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1b704a240c1dbc25ec8bbe82f71e8fb3c447af99\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581600612707297",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168558",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053995334888462944",
"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/8888565272358912192/+/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": "1581600612707408",
"url": "https://ci.chromium.org/b/8888565272358912192",
"utcnow_ts": "1581600612853729"
}
}
[13:30:12.863] Task URL: https://ci.chromium.org/b/8888565272358912192
[13:30:12.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:2:0) after 1m0s
[13:31:13.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:2:0)
[13:31:13.873] Timer tick, asking Buildbucket for the build status
[13:31:14.007] Build 8888565272358912192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:14.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:3:0) after 1m0s
[13:32:14.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:3:0)
[13:32:14.472] Timer tick, asking Buildbucket for the build status
[13:32:14.682] Build 8888565272358912192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:14.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:4:0) after 1m0s
[13:33:14.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:4:0)
[13:33:14.866] Timer tick, asking Buildbucket for the build status
[13:33:15.840] Build 8888565272358912192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:15.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:5:0) after 1m0s
[13:34:16.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:5:0)
[13:34:16.025] Timer tick, asking Buildbucket for the build status
[13:34:16.217] Build 8888565272358912192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:16.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:6:0) after 1m0s
[13:35:16.119] Received PubSub notification, asking Buildbucket for the build status
[13:35:16.544] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:16.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:6:0)
[13:35:16.908] Timer tick, asking Buildbucket for the build status
[13:35:17.030] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:17.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:8:0) after 1m0s
[13:36:17.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:8:0)
[13:36:17.139] Timer tick, asking Buildbucket for the build status
[13:36:17.800] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:17.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:9:0) after 1m0s
[13:37:17.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:9:0)
[13:37:17.873] Timer tick, asking Buildbucket for the build status
[13:37:18.185] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:18.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:10:0) after 1m0s
[13:38:18.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:10:0)
[13:38:18.249] Timer tick, asking Buildbucket for the build status
[13:38:18.727] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:18.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:11:0) after 1m0s
[13:39:18.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:11:0)
[13:39:18.716] Timer tick, asking Buildbucket for the build status
[13:39:19.085] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:19.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:12:0) after 1m0s
[13:40:19.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:12:0)
[13:40:19.205] Timer tick, asking Buildbucket for the build status
[13:40:19.345] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:19.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:13:0) after 1m0s
[13:41:19.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:13:0)
[13:41:19.406] Timer tick, asking Buildbucket for the build status
[13:41:19.619] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:19.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:14:0) after 1m0s
[13:42:19.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:14:0)
[13:42:19.612] Timer tick, asking Buildbucket for the build status
[13:42:19.781] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:19.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:15:0) after 1m0s
[13:43:19.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:15:0)
[13:43:19.802] Timer tick, asking Buildbucket for the build status
[13:43:20.079] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:20.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:16:0) after 1m0s
[13:44:20.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:16:0)
[13:44:20.113] Timer tick, asking Buildbucket for the build status
[13:44:20.742] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:20.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:17:0) after 1m0s
[13:45:20.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:17:0)
[13:45:20.859] Timer tick, asking Buildbucket for the build status
[13:45:21.168] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:18:0) after 1m0s
[13:46:21.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:18:0)
[13:46:21.187] Timer tick, asking Buildbucket for the build status
[13:46:21.322] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:21.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:19:0) after 1m0s
[13:47:21.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:19:0)
[13:47:21.430] Timer tick, asking Buildbucket for the build status
[13:47:21.591] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:21.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:20:0) after 1m0s
[13:48:21.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:20:0)
[13:48:21.843] Timer tick, asking Buildbucket for the build status
[13:48:22.034] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:22.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:21:0) after 1m0s
[13:49:22.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:21:0)
[13:49:22.018] Timer tick, asking Buildbucket for the build status
[13:49:22.211] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:22.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:22:0) after 1m0s
[13:50:22.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:22:0)
[13:50:22.272] Timer tick, asking Buildbucket for the build status
[13:50:24.269] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:24.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:23:0) after 1m0s
[13:51:24.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:23:0)
[13:51:24.367] Timer tick, asking Buildbucket for the build status
[13:51:24.513] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:24:0) after 1m0s
[13:52:24.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:24:0)
[13:52:24.601] Timer tick, asking Buildbucket for the build status
[13:52:24.753] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:24.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:25:0) after 1m0s
[13:53:24.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:25:0)
[13:53:24.944] Timer tick, asking Buildbucket for the build status
[13:53:25.321] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:25.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:26:0) after 1m0s
[13:54:25.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:26:0)
[13:54:25.455] Timer tick, asking Buildbucket for the build status
[13:54:25.607] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:25.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:27:0) after 1m0s
[13:55:25.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:27:0)
[13:55:25.774] Timer tick, asking Buildbucket for the build status
[13:55:27.989] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:27.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:28:0) after 1m0s
[13:56:27.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:28:0)
[13:56:27.986] Timer tick, asking Buildbucket for the build status
[13:56:28.314] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:28.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:29:0) after 1m0s
[13:57:28.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:29:0)
[13:57:28.363] Timer tick, asking Buildbucket for the build status
[13:57:28.695] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:28.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:30:0) after 1m0s
[13:58:28.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:30:0)
[13:58:28.884] Timer tick, asking Buildbucket for the build status
[13:58:29.760] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:29.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:31:0) after 1m0s
[13:59:29.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:31:0)
[13:59:29.847] Timer tick, asking Buildbucket for the build status
[13:59:30.856] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:30.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:32:0) after 1m0s
[14:00:31.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:32:0)
[14:00:31.121] Timer tick, asking Buildbucket for the build status
[14:00:31.303] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:31.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:33:0) after 1m0s
[14:01:31.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:33:0)
[14:01:31.390] Timer tick, asking Buildbucket for the build status
[14:01:31.769] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:31.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:34:0) after 1m0s
[14:02:31.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:34:0)
[14:02:31.928] Timer tick, asking Buildbucket for the build status
[14:02:32.334] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:32.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:35:0) after 1m0s
[14:03:32.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:35:0)
[14:03:32.355] Timer tick, asking Buildbucket for the build status
[14:03:32.694] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:32.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:36:0) after 1m0s
[14:04:32.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:36:0)
[14:04:32.755] Timer tick, asking Buildbucket for the build status
[14:04:32.913] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:32.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:37:0) after 1m0s
[14:05:33.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:37:0)
[14:05:33.090] Timer tick, asking Buildbucket for the build status
[14:05:33.374] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:33.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:38:0) after 1m0s
[14:06:33.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:38:0)
[14:06:33.479] Timer tick, asking Buildbucket for the build status
[14:06:33.603] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:33.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:39:0) after 1m0s
[14:07:33.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:39:0)
[14:07:33.602] Timer tick, asking Buildbucket for the build status
[14:07:33.819] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:33.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:40:0) after 1m0s
[14:08:33.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:40:0)
[14:08:33.958] Timer tick, asking Buildbucket for the build status
[14:08:34.226] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:34.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:41:0) after 1m0s
[14:09:34.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:41:0)
[14:09:34.342] Timer tick, asking Buildbucket for the build status
[14:09:34.509] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:34.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:42:0) after 1m0s
[14:10:34.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:42:0)
[14:10:34.537] Timer tick, asking Buildbucket for the build status
[14:10:34.868] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:34.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:43:0) after 1m0s
[14:11:35.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:43:0)
[14:11:35.077] Timer tick, asking Buildbucket for the build status
[14:11:35.365] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:35.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:44:0) after 1m0s
[14:12:35.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:44:0)
[14:12:35.499] Timer tick, asking Buildbucket for the build status
[14:12:35.661] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:35.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:45:0) after 1m0s
[14:13:35.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:45:0)
[14:13:35.934] Timer tick, asking Buildbucket for the build status
[14:13:36.396] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:36.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:46:0) after 1m0s
[14:14:36.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:46:0)
[14:14:36.596] Timer tick, asking Buildbucket for the build status
[14:14:36.991] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:36.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:47:0) after 1m0s
[14:15:37.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:47:0)
[14:15:37.293] Timer tick, asking Buildbucket for the build status
[14:15:37.588] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:37.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:48:0) after 1m0s
[14:16:37.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:48:0)
[14:16:37.675] Timer tick, asking Buildbucket for the build status
[14:16:37.881] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:37.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:49:0) after 1m0s
[14:17:37.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:49:0)
[14:17:37.912] Timer tick, asking Buildbucket for the build status
[14:17:38.149] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:38.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:50:0) after 1m0s
[14:18:38.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:50:0)
[14:18:38.195] Timer tick, asking Buildbucket for the build status
[14:18:39.048] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:39.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:51:0) after 1m0s
[14:19:39.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:51:0)
[14:19:39.085] Timer tick, asking Buildbucket for the build status
[14:19:39.231] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:39.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:52:0) after 1m0s
[14:20:39.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:52:0)
[14:20:39.255] Timer tick, asking Buildbucket for the build status
[14:20:39.427] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:39.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:53:0) after 1m0s
[14:21:39.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:53:0)
[14:21:39.486] Timer tick, asking Buildbucket for the build status
[14:21:40.332] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:40.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:54:0) after 1m0s
[14:22:40.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:54:0)
[14:22:40.367] Timer tick, asking Buildbucket for the build status
[14:22:40.707] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:40.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:55:0) after 1m0s
[14:23:40.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:55:0)
[14:23:40.763] Timer tick, asking Buildbucket for the build status
[14:23:40.912] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:40.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:56:0) after 1m0s
[14:24:40.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:56:0)
[14:24:40.973] Timer tick, asking Buildbucket for the build status
[14:24:41.310] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:41.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:57:0) after 1m0s
[14:25:41.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:57:0)
[14:25:41.376] Timer tick, asking Buildbucket for the build status
[14:25:41.608] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:41.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:58:0) after 1m0s
[14:26:41.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:58:0)
[14:26:41.713] Timer tick, asking Buildbucket for the build status
[14:26:41.845] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:41.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:59:0) after 1m0s
[14:27:41.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:59:0)
[14:27:41.945] Timer tick, asking Buildbucket for the build status
[14:27:42.979] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:42.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:60:0) after 1m0s
[14:28:43.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:60:0)
[14:28:43.100] Timer tick, asking Buildbucket for the build status
[14:28:43.687] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:43.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:61:0) after 1m0s
[14:29:43.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:61:0)
[14:29:43.738] Timer tick, asking Buildbucket for the build status
[14:29:45.296] Build 8888565272358912192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:45.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053995334888462944:62:0) after 1m0s
[14:30:28.482] Received PubSub notification, asking Buildbucket for the build status
[14:30:28.915] Build 8888565272358912192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:30:28.915] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581604196022923",
"created_by": "project:chromium",
"created_ts": "1581600612258502",
"id": "8888565272358912192",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1b704a240c1dbc25ec8bbe82f71e8fb3c447af99\"}}",
"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\"}, \"$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-98-jral\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168558, \"got_angle_revision\": \"77a5100d9a9a87d25e3aa2f66656cb47718b1afa\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"1b704a240c1dbc25ec8bbe82f71e8fb3c447af99\", \"got_revision_cp\": \"refs/heads/master@{#741038}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"ac4e1d236088f90e3bc97aa67002ffe56042e4f2\", \"got_v8_revision\": \"acf9c0def690e10a2dc454d0c0aab1ff73ec7cee\", \"got_v8_revision_cp\": \"refs/heads/8.2.67@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1b704a240c1dbc25ec8bbe82f71e8fb3c447af99\", \"swarm_hashes_refs/heads/master(at){#741038}_without_patch\": {\"accessibility_unittests\": \"28e3c1c0494ed5816c518ad86ca9018318e85a0c\", \"angle_unittests\": \"7c62a4243dc8c1801af9ddc0df5cad833441d8e8\", \"app_shell_unittests\": \"2cbb11f3be67fe6389a12bf9b2dc2309a696db14\", \"aura_unittests\": \"fcfcd2ac4c0ada7a2d5cf15313c8263b4a1a12b0\", \"base_unittests\": \"cd70d6144e3238b8047ce9058a2938f01fb1271c\", \"base_util_unittests\": \"e17668784acbfa58b724b1c3f35cf3c631b506e7\", \"blink_common_unittests\": \"1467bd9f0d5794d3548f3aa07b293f8b7119c45c\", \"blink_fuzzer_unittests\": \"9532d03d2cf9a1e2dca3d1d64b73c5c86d58808c\", \"blink_heap_unittests\": \"5f11e4ddf1695d4a72d30db3b257160b142893ef\", \"blink_platform_unittests\": \"f238596a71d108dcf1db182091c37e6c983f7f3e\", \"blink_python_tests\": \"7d86a828ed53ba624905d73f08abb20d97c064c4\", \"blink_unittests\": \"09c51dce83acfed5f024a33cccceae2116716dc4\", \"blink_web_tests\": \"4616cccfc030603e4b73f6d91c5ec370c4c1c0b4\", \"boringssl_crypto_tests\": \"b87a055c98d697df135e48b0c23327df3468e283\", \"boringssl_ssl_tests\": \"98d469f6f38158412495b377357c0d4ac7d11c97\", \"browser_tests\": \"9350ace627bf0b7b7fea234e901ed4e2ba96e3e2\", \"cacheinvalidation_unittests\": \"63312ec567db8c629f743fe998eddfda58183bcb\", \"capture_unittests\": \"da75ea58239774fd44a2bfc324a70ba8cbc75037\", \"cast_unittests\": \"da180d7ac64b2c3cae85675962678477cfcdf1c7\", \"cc_unittests\": \"a7157870c8d95885e89167b63a684a65ccb89c3f\", \"chrome_app_unittests\": \"abd88bd04a3248b6509a3e9e16ae288f2d60587c\", \"chromedriver_unittests\": \"a0f96d99e1b5744bd459ae3bba6160aff501d221\", \"components_browsertests\": \"86e87a22640a92858b62c9a7c89ef0e651097db1\", \"components_unittests\": \"5d9dc025897f6b8886f4c476646245a86419793a\", \"compositor_unittests\": \"d1aec9e65501d64e0119c7517f9f18dfd5c6e09c\", \"content_browsertests\": \"3745db3a04d66c5f303440b243bd5b611f27cdd9\", \"content_shell_crash_test\": \"551fc2dc7cd8e6d7cd85042d1f74f02ac3a354dd\", \"content_unittests\": \"ee28edb7ca50ae9668c70e4eb3560f3a850105c6\", \"crashpad_tests\": \"e12d70617f5414d5734e54cf7cf7e76a1c138961\", \"cronet_tests\": \"79b573ab7e61fa56e861a64675addb7c62b649bb\", \"cronet_unittests\": \"43c209b02b32f917f5fa3c6b0733c8981fbe00e3\", \"crypto_unittests\": \"1924ae41beaaf91a8b7d97335bdd1bbe1751d70e\", \"dbus_unittests\": \"bab92fd98e2699ee4ede963aac0c36b8ee990add\", \"device_unittests\": \"96ce0a3f9f34cb99b74e9555c5bc86fafc938335\", \"display_unittests\": \"3cd30a0306914ec325a17f4af0dbd3ebdf348766\", \"events_unittests\": \"5ea2a3ce3dd13656ac8ca160aafefe56cffb6cf2\", \"extensions_browsertests\": \"104f3ea4018cb48383f110fcfcfaf787c5ee103b\", \"extensions_unittests\": \"2cd07a9cd475399f0695fb3182508e7785db553e\", \"filesystem_service_unittests\": \"c8651e8a37b5c3cdb2c131085bf84931d3c0986e\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"e6679f804ba87d44b39e44788dec51b6b9bee3f6\", \"gfx_unittests\": \"871b5b63181dda4c9680e52894dbbc143976af77\", \"gin_unittests\": \"210e2288bf878bc7c25cf7874870ca57085e579f\", \"google_apis_unittests\": \"350a884d22ccf79d9dee51a7386273f8a53acf25\", \"gpu_unittests\": \"135d50330a24a307b7053c99f63734fa57508073\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"fab8b58188083ab0d7ea803f315934d46c509def\", \"headless_browsertests\": \"5a939b32d50f4627e0a48c37930f69ebe621d714\", \"headless_unittests\": \"8c9225ed15cb5cc0c44878dd902e5c3773473521\", \"interactive_ui_tests\": \"c3caf452f2d47b9fb33cb62d0273ea90f69b0305\", \"ipc_tests\": \"01503b4e1ac71543302751a4936bf3e0aee4a3ee\", \"jingle_unittests\": \"71c025add934060d200c90463babb9c706c9715a\", \"latency_unittests\": \"374d318910c48e6bd82212f5886b8a2b5cec5544\", \"libjingle_xmpp_unittests\": \"3470d7d77992d659dc720d8bce96b5fd0e7edb14\", \"media_blink_unittests\": \"35ea586203b96608c3ce09411aac3f53cbbcb71d\", \"media_service_unittests\": \"bca528af8940a7e1c6522556b335f2c16b8a8e23\", \"media_unittests\": \"316cf6b56ae31619aed091c05c9c37c1d2a283bc\", \"message_center_unittests\": \"d39b382752acc5fef22d8b6aba09bc455e61bcc7\", \"metrics_python_tests\": \"7e3db18d01b0ce512479ece701ff1fe297fc3305\", \"midi_unittests\": \"220f68d93f7faf1c351dc0de8c9e177d8b4c6ecb\", \"mojo_core_unittests\": \"37d934fe119ab7e718daeca692ae912773e6bf51\", \"mojo_unittests\": \"4ff7f3f9c4237dd1873be4a226347b75475d06dc\", \"nacl_helper_nonsfi_unittests\": \"1b7c37e43aa25cebc010dee06effda0066402797\", \"nacl_loader_unittests\": \"0a55fe3f00753778ab12d919908738b3933e511e\", \"native_theme_unittests\": \"996b404c42ebda6a2d53c1737c7985601db6db0e\", \"net_unittests\": \"392cf02973270e6de4de42e98c47677bf4e4107d\", \"pdf_unittests\": \"323d21a85aac5d806abe7cd2bc01b55267d885e2\", \"perfetto_unittests\": \"0f93b3731a0153693ce3cb7e8c33dce71004662d\", \"ppapi_unittests\": \"3bb2590210ca6286a93582fb6d07216ce4abe898\", \"printing_unittests\": \"cef6946f3c4ba318403e738ee0414f4e8332268a\", \"remoting_unittests\": \"b77e69375e182bb5e3908bdc3fe2e27333e20d4e\", \"sandbox_linux_unittests\": \"c954623bc4b652987c727c1e551e31948f025985\", \"service_manager_unittests\": \"6f02d85b59f96fb3e3474efe5fa394616c4fc10a\", \"services_unittests\": \"92f15ae1f45b79dc0f79586e7d846297dccb489d\", \"shell_dialogs_unittests\": \"d60f0d7395b20e0874327737f1102cc3ba49a9be\", \"skia_unittests\": \"9f60442cfd2b26a1797876d554ae910bca493e06\", \"snapshot_unittests\": \"610a11038aa31c39eb5f6edcddb7f3d17b8de496\", \"sql_unittests\": \"8b93b52ade2ec6ac586908db0d2057e13fc6e8ae\", \"storage_unittests\": \"6324263c5de5eb40d28d7b9985b37131d4fdccbd\", \"sync_integration_tests\": \"a7474b902e40ba89b2d69f36054d081b038c01b2\", \"telemetry_gpu_unittests\": \"c5f06b2243f8cbb8237718b5aa321e21e18de159\", \"telemetry_perf_unittests\": \"f6fed32b085fd4c7ffd53d41be7b7d18cb6739de\", \"telemetry_unittests\": \"887a9b23f5e288ffcafd65771a7c38535b3f806c\", \"traffic_annotation_auditor_unittests\": \"a88862794e0672dce1e4f5f9039cfdd5ce635821\", \"ui_base_unittests\": \"19aea5871e726c75fd32105780302cee16530b8d\", \"ui_touch_selection_unittests\": \"0ef6190b7cc11a26f77ed88f6b3e6a32bf5eb148\", \"unit_tests\": \"6f19d36f631b7490156f5bed4142ba9e5db748ae\", \"url_unittests\": \"824719361fa5bd4f352953d4e1866ef4e9a69901\", \"views_perftests\": \"45688d9f10f9f6b00a074a8a7b3da3dc25c708a2\", \"views_unittests\": \"695a56f40d21b2b9f8a1c87fa583b6ea390238e0\", \"viz_unittests\": \"ef84b755b0d344fb44a677fd79183f5342dcf262\", \"vr_common_unittests\": \"40198c534f22c33b5413e4033fa33ce291462487\", \"vr_pixeltests\": \"dc7779febccb64f7ca5e8c640402e781e2a16138\", \"webdriver_wpt_tests\": \"434d17afd8ba1faaa1692cc5e16a82a3dbd708b1\", \"weblayer_browsertests\": \"a5564fd89d87ce3a0b6386a4f865d3984530bf51\", \"wm_unittests\": \"43177f8ca68e24f94155a3ee140fb0cef63d423e\", \"wtf_unittests\": \"eb9903a41bb7076287ee9ec00cd46744e8cc4fd9\", \"xr_browser_tests\": \"575e086cfcf02515a81c84efd906ec46d9fb9374\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0095fe006eafdabf54002a791fb8c836a288874203ece8347c24b74b8d090ce3_v2\", \"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_4146122e9519f0d375bf270f7dbe7aaaad2aebc25c303d6d6f0d3252ec13806e_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_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-98-jral\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581600906306288",
"status": "COMPLETED",
"status_changed_ts": "1581604228164798",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168558",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b704a240c1dbc25ec8bbe82f71e8fb3c447af99",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053995334888462944",
"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/8888565272358912192/+/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:4a578facbc0c5910",
"user_agent:luci-scheduler"
],
"updated_ts": "1581604228186226",
"url": "https://ci.chromium.org/b/8888565272358912192",
"utcnow_ts": "1581604228888915"
}
}
[14:30:28.915] Invocation finished in 1h0m18.452690756s with status SUCCEEDED