[14:44:09.504] New invocation is queued and will start shortly
[14:44:12.023] Starting the invocation (attempt 1)
[14:44:12.275] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:12.276] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:12.276] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054171874182319664",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0008d362d39be97e60baa2695de45a79b694ae5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054171874182319664",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/0008d362d39be97e60baa2695de45a79b694ae5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0008d362d39be97e60baa2695de45a79b694ae5c",
"gitiles_ref:refs/heads/master"
]
}
[14:44:13.430] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581432252638395",
"id": "8888741810215769504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0008d362d39be97e60baa2695de45a79b694ae5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581432253214890",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168485",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0008d362d39be97e60baa2695de45a79b694ae5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0008d362d39be97e60baa2695de45a79b694ae5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054171874182319664",
"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/8888741810215769504/+/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": "1581432253214987",
"url": "https://ci.chromium.org/b/8888741810215769504",
"utcnow_ts": "1581432253422561"
}
}
[14:44:13.430] Task URL: https://ci.chromium.org/b/8888741810215769504
[14:44:13.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:2:0) after 1m0s
[14:45:13.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:2:0)
[14:45:13.464] Timer tick, asking Buildbucket for the build status
[14:45:13.610] Build 8888741810215769504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:45:13.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:3:0) after 1m0s
[14:46:13.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:3:0)
[14:46:13.670] Timer tick, asking Buildbucket for the build status
[14:46:13.819] Build 8888741810215769504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:13.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:4:0) after 1m0s
[14:47:13.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:4:0)
[14:47:13.856] Timer tick, asking Buildbucket for the build status
[14:47:14.080] Build 8888741810215769504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:14.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:5:0) after 1m0s
[14:48:14.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:5:0)
[14:48:14.136] Timer tick, asking Buildbucket for the build status
[14:48:14.285] Build 8888741810215769504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:14.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:6:0) after 1m0s
[14:49:04.204] Received PubSub notification, asking Buildbucket for the build status
[14:49:04.331] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:14.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:6:0)
[14:49:14.428] Timer tick, asking Buildbucket for the build status
[14:49:14.657] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:14.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:8:0) after 1m0s
[14:50:14.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:8:0)
[14:50:14.744] Timer tick, asking Buildbucket for the build status
[14:50:14.958] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:14.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:9:0) after 1m0s
[14:51:14.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:9:0)
[14:51:14.963] Timer tick, asking Buildbucket for the build status
[14:51:15.584] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:15.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:10:0) after 1m0s
[14:52:15.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:10:0)
[14:52:15.618] Timer tick, asking Buildbucket for the build status
[14:52:16.043] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:16.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:11:0) after 1m0s
[14:53:16.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:11:0)
[14:53:16.173] Timer tick, asking Buildbucket for the build status
[14:53:16.446] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:16.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:12:0) after 1m0s
[14:54:16.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:12:0)
[14:54:16.961] Timer tick, asking Buildbucket for the build status
[14:54:17.300] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:17.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:13:0) after 1m0s
[14:55:17.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:13:0)
[14:55:17.294] Timer tick, asking Buildbucket for the build status
[14:55:17.422] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:17.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:14:0) after 1m0s
[14:56:17.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:14:0)
[14:56:17.500] Timer tick, asking Buildbucket for the build status
[14:56:17.651] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:17.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:15:0) after 1m0s
[14:57:17.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:15:0)
[14:57:17.772] Timer tick, asking Buildbucket for the build status
[14:57:18.207] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:18.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:16:0) after 1m0s
[14:58:18.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:16:0)
[14:58:18.263] Timer tick, asking Buildbucket for the build status
[14:58:18.456] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:18.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:17:0) after 1m0s
[14:59:18.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:17:0)
[14:59:18.516] Timer tick, asking Buildbucket for the build status
[14:59:19.253] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:19.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:18:0) after 1m0s
[15:00:19.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:18:0)
[15:00:19.363] Timer tick, asking Buildbucket for the build status
[15:00:19.551] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:19.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:19:0) after 1m0s
[15:01:19.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:19:0)
[15:01:19.628] Timer tick, asking Buildbucket for the build status
[15:01:20.603] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:20:0) after 1m0s
[15:02:20.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:20:0)
[15:02:20.634] Timer tick, asking Buildbucket for the build status
[15:02:21.310] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:21.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:21:0) after 1m0s
[15:03:21.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:21:0)
[15:03:21.374] Timer tick, asking Buildbucket for the build status
[15:03:21.856] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:21.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:22:0) after 1m0s
[15:04:21.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:22:0)
[15:04:21.856] Timer tick, asking Buildbucket for the build status
[15:04:22.083] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:22.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:23:0) after 1m0s
[15:05:22.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:23:0)
[15:05:22.122] Timer tick, asking Buildbucket for the build status
[15:05:23.078] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:23.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:24:0) after 1m0s
[15:06:23.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:24:0)
[15:06:23.143] Timer tick, asking Buildbucket for the build status
[15:06:23.339] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:23.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:25:0) after 1m0s
[15:07:23.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:25:0)
[15:07:23.428] Timer tick, asking Buildbucket for the build status
[15:07:24.513] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:26:0) after 1m0s
[15:08:24.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:26:0)
[15:08:24.592] Timer tick, asking Buildbucket for the build status
[15:08:24.783] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:24.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:27:0) after 1m0s
[15:09:24.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:27:0)
[15:09:24.853] Timer tick, asking Buildbucket for the build status
[15:09:25.660] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:25.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:28:0) after 1m0s
[15:10:25.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:28:0)
[15:10:25.716] Timer tick, asking Buildbucket for the build status
[15:10:25.971] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:25.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:29:0) after 1m0s
[15:11:25.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:29:0)
[15:11:25.993] Timer tick, asking Buildbucket for the build status
[15:11:26.773] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:26.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:30:0) after 1m0s
[15:12:26.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:30:0)
[15:12:26.835] Timer tick, asking Buildbucket for the build status
[15:12:27.065] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:27.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:31:0) after 1m0s
[15:13:27.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:31:0)
[15:13:27.117] Timer tick, asking Buildbucket for the build status
[15:13:27.654] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:27.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:32:0) after 1m0s
[15:14:27.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:32:0)
[15:14:27.714] Timer tick, asking Buildbucket for the build status
[15:14:27.915] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:27.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:33:0) after 1m0s
[15:15:27.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:33:0)
[15:15:27.940] Timer tick, asking Buildbucket for the build status
[15:15:28.367] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:28.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:34:0) after 1m0s
[15:16:28.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:34:0)
[15:16:28.441] Timer tick, asking Buildbucket for the build status
[15:16:28.903] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:28.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:35:0) after 1m0s
[15:17:28.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:35:0)
[15:17:28.997] Timer tick, asking Buildbucket for the build status
[15:17:29.392] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:29.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:36:0) after 1m0s
[15:18:29.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:36:0)
[15:18:29.421] Timer tick, asking Buildbucket for the build status
[15:18:30.318] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:30.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:37:0) after 1m0s
[15:19:30.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:37:0)
[15:19:30.347] Timer tick, asking Buildbucket for the build status
[15:19:30.739] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:30.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:38:0) after 1m0s
[15:20:30.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:38:0)
[15:20:30.764] Timer tick, asking Buildbucket for the build status
[15:20:32.335] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:32.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:39:0) after 1m0s
[15:21:32.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:39:0)
[15:21:32.464] Timer tick, asking Buildbucket for the build status
[15:21:32.673] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:32.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:40:0) after 1m0s
[15:22:32.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:40:0)
[15:22:32.763] Timer tick, asking Buildbucket for the build status
[15:22:33.956] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:33.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:41:0) after 1m0s
[15:23:33.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:41:0)
[15:23:33.991] Timer tick, asking Buildbucket for the build status
[15:23:34.588] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:34.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:42:0) after 1m0s
[15:24:34.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:42:0)
[15:24:34.730] Timer tick, asking Buildbucket for the build status
[15:24:35.261] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:35.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:43:0) after 1m0s
[15:25:35.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:43:0)
[15:25:35.364] Timer tick, asking Buildbucket for the build status
[15:25:35.740] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:35.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:44:0) after 1m0s
[15:26:35.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:44:0)
[15:26:35.832] Timer tick, asking Buildbucket for the build status
[15:26:35.960] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:35.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:45:0) after 1m0s
[15:27:35.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:45:0)
[15:27:35.982] Timer tick, asking Buildbucket for the build status
[15:27:36.140] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:36.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:46:0) after 1m0s
[15:28:36.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:46:0)
[15:28:36.170] Timer tick, asking Buildbucket for the build status
[15:28:36.981] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:36.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:47:0) after 1m0s
[15:29:37.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:47:0)
[15:29:37.157] Timer tick, asking Buildbucket for the build status
[15:29:37.724] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:37.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:48:0) after 1m0s
[15:30:37.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:48:0)
[15:30:37.770] Timer tick, asking Buildbucket for the build status
[15:30:38.019] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:38.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:49:0) after 1m0s
[15:31:38.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:49:0)
[15:31:38.146] Timer tick, asking Buildbucket for the build status
[15:31:38.305] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:38.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:50:0) after 1m0s
[15:32:38.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:50:0)
[15:32:38.342] Timer tick, asking Buildbucket for the build status
[15:32:38.582] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:38.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:51:0) after 1m0s
[15:33:38.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:51:0)
[15:33:38.679] Timer tick, asking Buildbucket for the build status
[15:33:38.987] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:38.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:52:0) after 1m0s
[15:34:39.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:52:0)
[15:34:39.065] Timer tick, asking Buildbucket for the build status
[15:34:39.664] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:39.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:53:0) after 1m0s
[15:35:39.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:53:0)
[15:35:39.798] Timer tick, asking Buildbucket for the build status
[15:35:39.951] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:39.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:54:0) after 1m0s
[15:36:39.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:54:0)
[15:36:39.985] Timer tick, asking Buildbucket for the build status
[15:36:40.195] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:40.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:55:0) after 1m0s
[15:37:40.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:55:0)
[15:37:40.274] Timer tick, asking Buildbucket for the build status
[15:37:40.507] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:40.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:56:0) after 1m0s
[15:38:40.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:56:0)
[15:38:40.542] Timer tick, asking Buildbucket for the build status
[15:38:41.177] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:41.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:57:0) after 1m0s
[15:39:41.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:57:0)
[15:39:41.233] Timer tick, asking Buildbucket for the build status
[15:39:41.949] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:41.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:58:0) after 1m0s
[15:40:41.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:58:0)
[15:40:41.944] Timer tick, asking Buildbucket for the build status
[15:40:43.755] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:43.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:59:0) after 1m0s
[15:41:43.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:59:0)
[15:41:43.764] Timer tick, asking Buildbucket for the build status
[15:41:44.310] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:44.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:60:0) after 1m0s
[15:42:44.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:60:0)
[15:42:44.440] Timer tick, asking Buildbucket for the build status
[15:42:44.610] Build 8888741810215769504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:44.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054171874182319664:61:0) after 1m0s
[15:43:39.039] Received PubSub notification, asking Buildbucket for the build status
[15:43:39.202] Build 8888741810215769504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:43:39.203] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581435818451213",
"created_by": "project:chromium",
"created_ts": "1581432252638395",
"id": "8888741810215769504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0008d362d39be97e60baa2695de45a79b694ae5c\"}}",
"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-129-qlv5\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168485, \"got_angle_revision\": \"b40d48a67c932625f349c6e58036c2d96b62489b\", \"got_dawn_revision\": \"713d9cbf939e525e025a69a17bda0bf51b449c47\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"0008d362d39be97e60baa2695de45a79b694ae5c\", \"got_revision_cp\": \"refs/heads/master@{#740292}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"196d81774ef86d1c6c2d028dd5407b47eaa51a99\", \"got_v8_revision\": \"d0da7b4db4d335d91a374ec3be53199c482e7174\", \"got_v8_revision_cp\": \"refs/heads/8.2.56@{#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\": \"0008d362d39be97e60baa2695de45a79b694ae5c\", \"swarm_hashes_refs/heads/master(at){#740292}_without_patch\": {\"accessibility_unittests\": \"3e3380f969b36530d016c9ca06cfd287f2ad3758\", \"angle_unittests\": \"45d49712fb055a6351f209eeb3aeb298900ed9ac\", \"app_shell_unittests\": \"ad7de63910275b7ac3b9d778b86b0b29fd3b0664\", \"aura_unittests\": \"85220acf2b31fba0e775f115fac0ada48397c88e\", \"base_unittests\": \"4a279df9abee128e01beee3d4b7496ec6e18c5c4\", \"base_util_unittests\": \"c05025d6be5cb337a3dbd3063e68ed2a1628689d\", \"blink_common_unittests\": \"04e127f4c6be6cf95727e89f5d5e760e406f8329\", \"blink_fuzzer_unittests\": \"3fe18aa3e79bdcf0cc14a7d4893ca8971e7f457b\", \"blink_heap_unittests\": \"a8fbf0cee51a9092034e71e98de30a7efc5a0610\", \"blink_platform_unittests\": \"610f0a5b7a0a4ec41c4c82e25eda1a643dadfa8b\", \"blink_python_tests\": \"ec2cd98d54b45dd73d2b3194d1cd009a08359eee\", \"blink_unittests\": \"39bda5cb49505ae810e1f8b2cb06251576ca900a\", \"blink_web_tests\": \"c6ae9095b0f1036fac21bd909ba56da0566c3a3c\", \"boringssl_crypto_tests\": \"95e11b3ad1485ef5ca655ac0b86d8ff3dba78047\", \"boringssl_ssl_tests\": \"8866b6c4ad6d38ade44b9b37bae3ea235aadd8cc\", \"browser_tests\": \"a165f45dfb606be7098232d656f43b14b7cdf570\", \"cacheinvalidation_unittests\": \"1d10521a9370a4731b63a49784b78475af69f943\", \"capture_unittests\": \"99388e0c3a8ee95b61f6b4b5280202f40787d1a4\", \"cast_unittests\": \"73f0efdf0667fc884f87cb2f356473b99fc02535\", \"cc_unittests\": \"2458e84fa2a419e5ea77ab17c20589963c9c80ed\", \"chrome_app_unittests\": \"73cdd00d586dd8ea0f0e9a02a02859e01fee64e7\", \"chromedriver_unittests\": \"cb594ff1dea948d051a800af0b93e7295b2a6813\", \"components_browsertests\": \"8ba270812d411385b903cfe6487c94c2e61d337e\", \"components_unittests\": \"329f04612f8e26d4c294d661af7a22e3992faa94\", \"compositor_unittests\": \"34b341710a5f86a9bf43b053cd9c6b03b16bb43b\", \"content_browsertests\": \"95aeb3bd6a4315090aa6d2a652440490c99daa9d\", \"content_shell_crash_test\": \"216e9d577144ad3d24a287242a39adeaa41f3e13\", \"content_unittests\": \"a514bd5af0be16a921aa31c38dbf7b0e2544960c\", \"crashpad_tests\": \"023803b06a5c1d9219866baadc639dd403479e66\", \"cronet_tests\": \"afb8d372033c3310d8645806fbb59e3891e9d745\", \"cronet_unittests\": \"e60d6dd46ec7f77542bdeb7da2245e53abe6d039\", \"crypto_unittests\": \"d22b6be1d474b603123318a330a4f75492406c0b\", \"dbus_unittests\": \"c6c5b33b5c4c1bd03bc012e23724f7a0b2e043ce\", \"device_unittests\": \"6a1a145278c376c2e206979ee094d2a7f31d2e26\", \"display_unittests\": \"24c75769801b538ba2efae811113489f339fde4c\", \"events_unittests\": \"cb23a03a70fa1a00110fd91f5d11b907930ed22f\", \"extensions_browsertests\": \"e78f9faf4892f2eb48c00f34b985c163a71e6ca9\", \"extensions_unittests\": \"0d7bb5a25147a7fb1956eaaa0f4db07bbb5b4047\", \"filesystem_service_unittests\": \"3d6a8fd75ea261b00a21ca9b3fae8c996ef395ee\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"7184b698e92ec2534be023e0d24a3e8884f18f09\", \"gfx_unittests\": \"c2d12804b89bd735492f7965f9ba12d0e4648549\", \"gin_unittests\": \"0af810b7f92219551b5eb753a7291fc3d700b0a9\", \"google_apis_unittests\": \"50e8073b92ca6df22f8327917296f3f56ccd5796\", \"gpu_unittests\": \"a88376fd8e7f9252e54bcf544f1a5d9bcc080b3c\", \"grit_python_unittests\": \"2c197a1bd065e31b00ed1c7636679f90a901aabe\", \"gwp_asan_unittests\": \"6fba2dccc1827b6afc3e6376d168a769b8d93843\", \"headless_browsertests\": \"90f8c42ca71071fa545246d8a09b573d974441cd\", \"headless_unittests\": \"0228cfa9b8140c2a24bbdde13be7791383453387\", \"interactive_ui_tests\": \"a4a70b1128a405d4fa011f17f001ea36835b32b1\", \"ipc_tests\": \"eaed91cb9e85f21f9ba771c2aa46928d8ca3d3d4\", \"jingle_unittests\": \"570f15b1c27b262070c63ef3fdae23dd2e9d1425\", \"latency_unittests\": \"24463cad2cfc3cdf5001f492307aeedd7c53609a\", \"libjingle_xmpp_unittests\": \"e9a128a14f8c998fe9e82a43f7418dafac36e1a3\", \"media_blink_unittests\": \"cba7adf1234fdbe72967e972ec5ef748314c1c86\", \"media_service_unittests\": \"84a8702636ae5f45132c0e99766467715bfbc5fa\", \"media_unittests\": \"4bec13c1daa26b8efe95af2db570964bf5159871\", \"message_center_unittests\": \"74f1ce3aaf12212102220ba7d4d9e148529564f2\", \"metrics_python_tests\": \"a71d4cbe85a0f1b717fb49eef2daa67f71126102\", \"midi_unittests\": \"6a2efd20b2ef6d361bd28f3bd66f0e0d587cd7f3\", \"mojo_core_unittests\": \"f88b9a3addfffc8a12d94a8ed58ea0f43f9a433a\", \"mojo_unittests\": \"6bd6ad0f798f6f4f21bd35ad56e157c2584f2d90\", \"nacl_helper_nonsfi_unittests\": \"34bfb4402e9d109cce9f85ddab7c2e0cb200480a\", \"nacl_loader_unittests\": \"46d3e6f85c0c37f3886b690ab2dbd75637c2242f\", \"native_theme_unittests\": \"7f3a6449ad91072d51e25bbe213b27fbd5f51778\", \"net_unittests\": \"0537664f2b48befebe7a35920534cb55241a83e8\", \"pdf_unittests\": \"e555a0c6312b145475140a189edceba402ce3df4\", \"perfetto_unittests\": \"a0abf6c6ff861323f27a0e76f608e7e4c047cd3b\", \"ppapi_unittests\": \"a1a6bd749ef37f90728811de4f1f0bc2f34192a8\", \"printing_unittests\": \"a651571e0cd6dfa2e831306478df0a0c28875152\", \"remoting_unittests\": \"7d6e411e57990feca16822ea9f3e2ca24bb98040\", \"sandbox_linux_unittests\": \"e8d4ed764c6c7c4768ad6000eb2e73ddb502bc6a\", \"service_manager_unittests\": \"a14905e1fe57da12afb0bc65762d68a5db0d2c5e\", \"services_unittests\": \"06662a57724009b15d241dc7f43340654310efe5\", \"shell_dialogs_unittests\": \"f8ec987822313e9130704d8884799faccbc4c5da\", \"skia_unittests\": \"c5ab3757dc596e743a5ae0747938255bfb975b98\", \"snapshot_unittests\": \"34ba2017fa36beade809c7908e72b712ef7e2b62\", \"sql_unittests\": \"1d3e703df90a5bbda98999360d9009e9aefeebd2\", \"storage_unittests\": \"64f04aa81e09b5582d6f3b59081ff9e0149fd03f\", \"sync_integration_tests\": \"839e4490a220ef3454eba2c3d99dccf03e8e67af\", \"telemetry_gpu_unittests\": \"1a3a12265eb47df766ed2cd6018f17e3878bc190\", \"telemetry_perf_unittests\": \"08c12720267db639cdcd63db2dade05e80487103\", \"telemetry_unittests\": \"18a28296533fff6afb3dcc4f9538a5ef045d7d34\", \"traffic_annotation_auditor_unittests\": \"e5d92524611892f7593cc41a33435f7b10b6b859\", \"ui_base_unittests\": \"45cb1247ce58ce98982a589647b4b635d829df05\", \"ui_touch_selection_unittests\": \"710f1e44e6966e7764f68be00d54c58b6c6181f7\", \"unit_tests\": \"7b593551b5569109a233bd48375e2832e18be9a5\", \"url_unittests\": \"49f2783dcb6b3311e0355455f39271753b48522a\", \"views_perftests\": \"84b0e117f0d8f88426d4fe3ddaed061e9f531b29\", \"views_unittests\": \"e0eab8183af6792eecb5b9ff13c5fb608bfb3898\", \"viz_unittests\": \"68e2abdd202b76c44f65b04ded30e2d10efcc633\", \"vr_common_unittests\": \"04efa6de4d4d5edc7cb269198a6a2f52359a1917\", \"vr_pixeltests\": \"94c4b6732ec209af3959abbc7e2d452ebc89b8e4\", \"webdriver_wpt_tests\": \"83cf913261f72156999893b6cd4a1dcb79c22252\", \"weblayer_browsertests\": \"475d19705ba0060e98da7b275d6dd231bc4143a2\", \"wm_unittests\": \"02eb36c699a6f7fce5a9a6e22fb7797d731e4ccf\", \"wtf_unittests\": \"eed3af1f427d81ecff52316ddecd73bd215f39d9\", \"xr_browser_tests\": \"f02767efe85312ab7ef826b44c42b83422a77cbd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_v2\", \"builder_9ccb21220795a1d1972030c6b5d9b4569472a28790e1458f6676edb8e4495e8f_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-129-qlv5\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581432542714579",
"status": "COMPLETED",
"status_changed_ts": "1581435818746702",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168485",
"builder:Linux Builder (dbg)",
"buildset:commit/git/0008d362d39be97e60baa2695de45a79b694ae5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0008d362d39be97e60baa2695de45a79b694ae5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054171874182319664",
"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/8888741810215769504/+/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:4a4d86b41a63dc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581435818751032",
"url": "https://ci.chromium.org/b/8888741810215769504",
"utcnow_ts": "1581435819190714"
}
}
[15:43:39.203] Invocation finished in 59m29.730313031s with status SUCCEEDED