[21:54:00.714] New invocation is queued and will start shortly
[21:54:02.510] Starting the invocation (attempt 1)
[21:54:02.564] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:54:02.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:54:02.565] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028868276497371568",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"259692674ef1b7ae6451910c714fb6340dbc1f9d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028868276497371568",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"gitiles_ref:refs/heads/master"
]
}
[21:54:03.527] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605563642704760",
"id": "8863438213746307696",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"259692674ef1b7ae6451910c714fb6340dbc1f9d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605563643315133",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177737",
"builder:Linux Builder (dbg)",
"buildset:commit/git/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028868276497371568",
"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/8863438213746307696/+/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": "1605563643315288",
"url": "https://ci.chromium.org/b/8863438213746307696",
"utcnow_ts": "1605563643518250"
}
}
[21:54:03.527] Task URL: https://ci.chromium.org/b/8863438213746307696
[21:54:03.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:2:0) after 1m0s
[21:54:15.075] Received PubSub notification, asking Buildbucket for the build status
[21:54:15.200] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:03.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:2:0)
[21:55:03.601] Timer tick, asking Buildbucket for the build status
[21:55:03.772] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:03.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:4:0) after 1m0s
[21:56:03.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:4:0)
[21:56:03.774] Timer tick, asking Buildbucket for the build status
[21:56:04.845] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:04.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:5:0) after 1m0s
[21:57:04.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:5:0)
[21:57:04.840] Timer tick, asking Buildbucket for the build status
[21:57:04.982] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:04.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:6:0) after 1m0s
[21:58:05.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:6:0)
[21:58:05.033] Timer tick, asking Buildbucket for the build status
[21:58:05.156] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:05.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:7:0) after 1m0s
[21:59:05.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:7:0)
[21:59:05.243] Timer tick, asking Buildbucket for the build status
[21:59:05.361] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:05.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:8:0) after 1m0s
[22:00:05.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:8:0)
[22:00:05.417] Timer tick, asking Buildbucket for the build status
[22:00:05.577] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:05.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:9:0) after 1m0s
[22:01:05.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:9:0)
[22:01:05.659] Timer tick, asking Buildbucket for the build status
[22:01:05.880] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:05.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:10:0) after 1m0s
[22:02:05.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:10:0)
[22:02:05.883] Timer tick, asking Buildbucket for the build status
[22:02:05.961] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:05.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:11:0) after 1m0s
[22:03:06.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:11:0)
[22:03:06.051] Timer tick, asking Buildbucket for the build status
[22:03:06.275] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:06.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:12:0) after 1m0s
[22:04:06.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:12:0)
[22:04:06.395] Timer tick, asking Buildbucket for the build status
[22:04:06.509] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:13:0) after 1m0s
[22:05:06.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:13:0)
[22:05:06.552] Timer tick, asking Buildbucket for the build status
[22:05:06.645] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:06.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:14:0) after 1m0s
[22:06:06.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:14:0)
[22:06:06.684] Timer tick, asking Buildbucket for the build status
[22:06:06.764] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:15:0) after 1m0s
[22:07:06.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:15:0)
[22:07:06.784] Timer tick, asking Buildbucket for the build status
[22:07:06.840] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:06.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:16:0) after 1m0s
[22:08:06.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:16:0)
[22:08:06.935] Timer tick, asking Buildbucket for the build status
[22:08:07.202] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:17:0) after 1m0s
[22:09:07.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:17:0)
[22:09:07.231] Timer tick, asking Buildbucket for the build status
[22:09:07.625] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:07.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:18:0) after 1m0s
[22:10:07.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:18:0)
[22:10:07.686] Timer tick, asking Buildbucket for the build status
[22:10:07.759] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:07.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:19:0) after 1m0s
[22:11:07.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:19:0)
[22:11:07.851] Timer tick, asking Buildbucket for the build status
[22:11:07.928] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:07.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:20:0) after 1m0s
[22:12:08.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:20:0)
[22:12:08.073] Timer tick, asking Buildbucket for the build status
[22:12:08.148] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:08.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:21:0) after 1m0s
[22:13:08.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:21:0)
[22:13:08.226] Timer tick, asking Buildbucket for the build status
[22:13:08.302] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:08.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:22:0) after 1m0s
[22:14:08.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:22:0)
[22:14:08.354] Timer tick, asking Buildbucket for the build status
[22:14:08.504] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:08.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:23:0) after 1m0s
[22:15:08.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:23:0)
[22:15:08.557] Timer tick, asking Buildbucket for the build status
[22:15:08.624] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:08.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:24:0) after 1m0s
[22:16:08.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:24:0)
[22:16:08.696] Timer tick, asking Buildbucket for the build status
[22:16:08.773] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:08.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:25:0) after 1m0s
[22:17:08.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:25:0)
[22:17:08.824] Timer tick, asking Buildbucket for the build status
[22:17:08.893] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:08.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:26:0) after 1m0s
[22:18:08.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:26:0)
[22:18:08.930] Timer tick, asking Buildbucket for the build status
[22:18:09.488] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:27:0) after 1m0s
[22:19:09.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:27:0)
[22:19:09.502] Timer tick, asking Buildbucket for the build status
[22:19:09.629] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:09.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:28:0) after 1m0s
[22:20:09.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:28:0)
[22:20:09.685] Timer tick, asking Buildbucket for the build status
[22:20:09.974] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:09.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:29:0) after 1m0s
[22:21:10.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:29:0)
[22:21:10.071] Timer tick, asking Buildbucket for the build status
[22:21:10.158] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:10.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:30:0) after 1m0s
[22:22:10.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:30:0)
[22:22:10.162] Timer tick, asking Buildbucket for the build status
[22:22:10.344] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:10.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:31:0) after 1m0s
[22:23:10.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:31:0)
[22:23:10.365] Timer tick, asking Buildbucket for the build status
[22:23:10.435] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:10.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:32:0) after 1m0s
[22:24:10.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:32:0)
[22:24:10.533] Timer tick, asking Buildbucket for the build status
[22:24:11.672] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:11.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:33:0) after 1m0s
[22:25:11.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:33:0)
[22:25:11.881] Timer tick, asking Buildbucket for the build status
[22:25:11.951] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:11.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:34:0) after 1m0s
[22:26:12.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:34:0)
[22:26:12.151] Timer tick, asking Buildbucket for the build status
[22:26:12.249] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:35:0) after 1m0s
[22:27:12.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:35:0)
[22:27:12.278] Timer tick, asking Buildbucket for the build status
[22:27:12.651] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:12.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:36:0) after 1m0s
[22:28:12.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:36:0)
[22:28:12.689] Timer tick, asking Buildbucket for the build status
[22:28:12.782] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:12.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:37:0) after 1m0s
[22:29:12.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:37:0)
[22:29:12.852] Timer tick, asking Buildbucket for the build status
[22:29:13.093] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:13.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:38:0) after 1m0s
[22:30:13.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:38:0)
[22:30:13.240] Timer tick, asking Buildbucket for the build status
[22:30:13.347] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:13.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:39:0) after 1m0s
[22:31:13.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:39:0)
[22:31:13.395] Timer tick, asking Buildbucket for the build status
[22:31:13.462] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:13.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:40:0) after 1m0s
[22:32:13.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:40:0)
[22:32:13.495] Timer tick, asking Buildbucket for the build status
[22:32:13.586] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:13.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:41:0) after 1m0s
[22:33:13.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:41:0)
[22:33:13.624] Timer tick, asking Buildbucket for the build status
[22:33:14.102] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:14.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:42:0) after 1m0s
[22:34:14.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:42:0)
[22:34:14.149] Timer tick, asking Buildbucket for the build status
[22:34:14.539] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:14.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:43:0) after 1m0s
[22:35:14.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:43:0)
[22:35:14.525] Timer tick, asking Buildbucket for the build status
[22:35:14.697] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:14.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:44:0) after 1m0s
[22:36:14.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:44:0)
[22:36:14.707] Timer tick, asking Buildbucket for the build status
[22:36:14.805] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:14.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:45:0) after 1m0s
[22:37:14.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:45:0)
[22:37:14.919] Timer tick, asking Buildbucket for the build status
[22:37:15.105] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:15.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:46:0) after 1m0s
[22:38:15.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:46:0)
[22:38:15.240] Timer tick, asking Buildbucket for the build status
[22:38:16.104] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:16.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:47:0) after 1m0s
[22:39:16.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:47:0)
[22:39:16.162] Timer tick, asking Buildbucket for the build status
[22:39:16.277] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:48:0) after 1m0s
[22:40:16.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:48:0)
[22:40:16.327] Timer tick, asking Buildbucket for the build status
[22:40:16.432] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:16.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:49:0) after 1m0s
[22:41:16.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:49:0)
[22:41:16.446] Timer tick, asking Buildbucket for the build status
[22:41:16.618] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:16.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:50:0) after 1m0s
[22:42:16.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:50:0)
[22:42:16.643] Timer tick, asking Buildbucket for the build status
[22:42:16.728] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:16.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:51:0) after 1m0s
[22:43:16.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:51:0)
[22:43:16.775] Timer tick, asking Buildbucket for the build status
[22:43:16.843] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:16.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:52:0) after 1m0s
[22:44:16.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:52:0)
[22:44:16.885] Timer tick, asking Buildbucket for the build status
[22:44:17.002] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:17.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:53:0) after 1m0s
[22:45:17.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:53:0)
[22:45:17.066] Timer tick, asking Buildbucket for the build status
[22:45:17.167] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:17.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:54:0) after 1m0s
[22:46:17.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:54:0)
[22:46:17.225] Timer tick, asking Buildbucket for the build status
[22:46:17.491] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:17.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:55:0) after 1m0s
[22:47:17.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:55:0)
[22:47:17.514] Timer tick, asking Buildbucket for the build status
[22:47:17.724] Build 8863438213746307696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:17.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028868276497371568:56:0) after 1m0s
[22:47:55.992] Received PubSub notification, asking Buildbucket for the build status
[22:47:56.443] Build 8863438213746307696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:47:56.443] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605566875236541",
"created_by": "project:chromium",
"created_ts": "1605563642704760",
"id": "8863438213746307696",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"259692674ef1b7ae6451910c714fb6340dbc1f9d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"259692674ef1b7ae6451910c714fb6340dbc1f9d\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-33-4q3b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177737, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"dd6b36e8801ebeee53342c295fb56812504db80d\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"259692674ef1b7ae6451910c714fb6340dbc1f9d\", \"got_revision_cp\": \"refs/heads/master@{#827907}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"3e551b3ce67ddeaf0a29516b4dc98375886daf51\", \"got_v8_revision\": \"cfb8bc492eb44482518665f7d1013d3c2e8f5000\", \"got_v8_revision_cp\": \"refs/heads/8.9.1@{#1}\", \"got_webrtc_revision\": \"02736010cb171c3cc36ea2039911a6dadec9952d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"259692674ef1b7ae6451910c714fb6340dbc1f9d\", \"swarm_hashes_refs/heads/master(at){#827907}_without_patch\": {\"absl_hardening_tests\": \"4d3a4b0d772998cacfb4759310287ffdf8d3e867\", \"accessibility_unittests\": \"67332c11ae60fe065198cf5bc449f009bfe75e78\", \"angle_unittests\": \"e9dab20d3a7bb9dce50f26f70d01666558bf673b\", \"app_shell_unittests\": \"a57d7901a5bb0f4e5c88d65a132f95fe8e8d553b\", \"aura_unittests\": \"7a9075b3addcd59a83fd3e22d62a9b3a6a276367\", \"base_unittests\": \"2bce735ebe196c32565e29b38b995faf10bcacc1\", \"base_util_unittests\": \"05aae0943492caa7d063c4a3701147296b23ca43\", \"blink_common_unittests\": \"48068d332855f51fa9a07412cad74734bb9f4aa1\", \"blink_fuzzer_unittests\": \"894cfd74d51b4278bc38153e877938e167908144\", \"blink_heap_unittests\": \"ff6b9fbecbf10047d6a5296ee542cd80e927869a\", \"blink_platform_unittests\": \"7652d311459dc3d78bc0102ad53fc33b66e84360\", \"blink_python_tests\": \"402193ce00a592711b4c11fbd69d7c2032fcff45\", \"blink_unittests\": \"1ca40edc4d7ecfd9b13e19089d024f97bb1ed8dc\", \"blink_web_tests\": \"df3c637d3a0bb877243dcca381bb97915dc50834\", \"boringssl_crypto_tests\": \"d6081fc6f2b7d1edd78ba3a0c0843aa6b001bd64\", \"boringssl_ssl_tests\": \"cd71e580644ca1fa20fe64f429cd8607298c35d7\", \"browser_tests\": \"5b1b0710d278290ad6f23491cfc78e398cb3ebba\", \"capture_unittests\": \"ef3e5b11728d47d46daa5d89a31069102f63c4a8\", \"cast_unittests\": \"9c0f08932886842742b7c8a22beaa7d662f82c8c\", \"cc_unittests\": \"9bbe3969fa82cc9bf8acb4e87afae8905bf9d799\", \"chrome_app_unittests\": \"b8d13a8d802598c59a382b09a0e8fa0253326f40\", \"chromedriver_unittests\": \"1f9a380fa1189f6c8017fea96d013d0ccd5be40a\", \"components_browsertests\": \"2f38e13341116f3c25dcda6c67a40d820a6939ce\", \"components_unittests\": \"de84bbe34e3f296f3d09015780e4fb254331e1ec\", \"compositor_unittests\": \"9d0621add2bc70b89b623406a965c1f93f5419d5\", \"content_browsertests\": \"2790a8da66e252e9c79aef25f608b0f6a033d069\", \"content_shell_crash_test\": \"33d5c4273dd338d1b2f5613e03eb2468eedf6ba4\", \"content_unittests\": \"43b533bcdb0cbebbe62bedad75a5fcb35a198940\", \"crashpad_tests\": \"8e322e6c8a5f78ea74fd71677bb43a88174bfd27\", \"cronet_tests\": \"3898fabe80ab543be9a372dfb09722a85554c32b\", \"cronet_unittests\": \"5b3a8e83a8b78cca6435ed60d2435563767b89e8\", \"crypto_unittests\": \"c9fab42cc50b508d8b218b617699694fa74858c1\", \"dbus_unittests\": \"d244860a471de23a83c839d3911de67048e4f072\", \"device_unittests\": \"e80272bef93d20c14b60f5b8ca9c1f25a8c869fe\", \"display_unittests\": \"cfa96956aa7e900f86bd9be2ac02a7485281d559\", \"events_unittests\": \"93c6e5cbbcb4bcbed03b7f0987e97f1a0c6df8a7\", \"extension_docserver_python_unittests\": \"51dc48714b7481777e95bfc60a0ef6f7ec900ce0\", \"extensions_browsertests\": \"649a6819f8014d610a5bb254fe11fca9e2419eea\", \"extensions_unittests\": \"87e0a5debf82cb96292af4635f66f57ef6fc75b4\", \"filesystem_service_unittests\": \"d7efa24fb6671847f41a4f30da6b6a5dfc745d93\", \"flatbuffers_unittests\": \"e44ed88e1dde0ef7f6136eb0949503718efe54b6\", \"gcm_unit_tests\": \"81b4268e61b76501823047d6fc6830519471afa0\", \"gfx_unittests\": \"c8aa75dfb50393e32b8b19175d9ecd7699b0d06b\", \"gin_unittests\": \"cf9b293c5cf91903154635c0f502c6af79824ea0\", \"google_apis_unittests\": \"625bc634e2376e121725d1f5a5f4cb427925424c\", \"gpu_unittests\": \"171e05d501e1c64cda2d2b1fede09ea5e12f1c70\", \"grit_python_unittests\": \"f4020ed5757956fbd2d0e1bd58035b529a5e6a74\", \"gwp_asan_unittests\": \"02f93cb1c148b9244b919449e15092bd42d959c2\", \"headless_browsertests\": \"8be986d6e336fe21b5a2330686eee6c99ac3aae4\", \"headless_unittests\": \"5b5561b6d0be83e23d8c501c0c78d33a559a9a44\", \"interactive_ui_tests\": \"27b2d3d03007028ca55e938c9b5f4c0253dba9ff\", \"ipc_tests\": \"6bf39d750b9b8f063b51ec0e732cafe0daf7f4a2\", \"jingle_unittests\": \"ebbc56bda879571a8eb8ed47676f98a13a4f9dd1\", \"latency_unittests\": \"05b5d76e860db81f385e5b516b1bf7cf86905ecc\", \"libjingle_xmpp_unittests\": \"01458b5acc0173463c90cc8bfc807133d2037192\", \"liburlpattern_unittests\": \"b74c22511241d3f0ae5528ebe98f29e8abc95f27\", \"media_blink_unittests\": \"d5ac7f03db264336a5acd97ab1b6f34848af7594\", \"media_unittests\": \"013dd023712d8aa97f47dbe956e9581a4caceafa\", \"message_center_unittests\": \"af6368189099e20b1cf4af8534371732bd81ea6f\", \"metrics_python_tests\": \"5f415b72e1f3fd35dc68125193631447454224b9\", \"midi_unittests\": \"1676d7d9957c9bffc0128f83ad8374b29a61846e\", \"mojo_core_unittests\": \"781f998cee790f18dcbbc3046ba10eceaa6dfcfb\", \"mojo_unittests\": \"cbb56eeb45349c3463de6d6162ee5a95add62658\", \"nacl_helper_nonsfi_unittests\": \"617d46f94fd2d563126a06504e408e0d4817a91f\", \"nacl_loader_unittests\": \"7a6e116d0d26dc663df8cc97f56509c6a1efc074\", \"native_theme_unittests\": \"9b9338e1ee90ecd100f7b1a59ea371a6f2d1ba5d\", \"net_unittests\": \"598af16ce152ba2e10c58df4beff6453134a2390\", \"openscreen_unittests\": \"7aa33492423b1d84f0d4863c43b7d8e95c1c26ac\", \"pdf_unittests\": \"238864cbdd90a4047bc1e69a4d9ae43506ff0b2e\", \"perfetto_unittests\": \"114973b37c5939cc2d180a3692c175c73a2beb96\", \"ppapi_unittests\": \"7e37e579193eb602ab439670522531087a1cebdd\", \"printing_unittests\": \"5e15ea360a1742a663a72afafc0a6c9c8254b0fe\", \"remoting_unittests\": \"e39b87a53750c6ef1dc7ad9e9eba4cae92ba8ea3\", \"sandbox_linux_unittests\": \"23b1efea354e5c7bbbad6544864fa76e02b1e33f\", \"service_manager_unittests\": \"daced0d37dccdfcc52d369f10d6259812bd335de\", \"services_unittests\": \"edb2bd4f5e2892e05b6421b5b78a07b3ec786194\", \"shell_dialogs_unittests\": \"8ea071e69dd1333e94fa71055cd2523ba0bd06c3\", \"skia_unittests\": \"8f55a2d60ece99db0738c4cbfea668372b2179ca\", \"snapshot_unittests\": \"25936b111fc2f4ec5d74dab1a2b96081696ed348\", \"sql_unittests\": \"dc562c6a115365246befad1c4eea0b5869918d5b\", \"storage_unittests\": \"936773df9f56f6b0796a308d987c6cf51f15c10e\", \"sync_integration_tests\": \"3a61772d2399e3c41e6caf9d39ec1f181e2739c0\", \"telemetry_gpu_unittests\": \"53f0902b701d72b4c31d098e66027e5b5c595458\", \"telemetry_perf_unittests\": \"20f8eff189b2e66706744330a68f1a20d8895f6a\", \"telemetry_unittests\": \"07585c540a343d1cd681989fdb1c63a184361c59\", \"traffic_annotation_auditor_unittests\": \"38f17d1af5035365bde467f501b42e53a3ba5cd2\", \"ui_base_unittests\": \"5e6872b7f73558413acaf08a24fbb5742a5b1185\", \"ui_touch_selection_unittests\": \"39137e82d74ea6e230c4cc35761ee464fea7ee46\", \"unit_tests\": \"ed29564c28990b643aae9d347b1d93a0c930ea17\", \"url_unittests\": \"ce765aad33301f943ae43ea40d8b12183af25719\", \"views_perftests\": \"182614ca021e03504b61b57652a0014cac6c7bee\", \"views_unittests\": \"31ac26690c884edd00408c24a178fd27267f243e\", \"viz_unittests\": \"e46ca4cc3a95836ffb86aaff02047c9ed0b86da4\", \"vr_common_unittests\": \"32a157c23949cde52005ce346e0d204e278d60c7\", \"vr_pixeltests\": \"25b9b87f65d55dfbcb25ea101ef324aeb1a1c347\", \"webdriver_wpt_tests\": \"ce69ab0d1096f1b805738bb86ad171fd36f30430\", \"weblayer_browsertests\": \"bafa8b32c694cb649eb43cc897078a83c194c15c\", \"weblayer_unittests\": \"c53b89c846ff97ff3f06744a7eb14138ecc2cb95\", \"wm_unittests\": \"0bc5b5fa6152c585b5c868cc898880b6bf7b9914\", \"wtf_unittests\": \"549cdc776bfbe20fc4c23a7bac7f0a676671455b\", \"x11_unittests\": \"349bf717f2e48f9cd89c7aa8425bbb12bc991556\", \"xr_browser_tests\": \"387ebbb201efae9061cf391701b02f1fb1bf7927\", \"zlib_unittests\": \"3643557a60e546fa26ae7b3bb2bfcefe4dc0a8df\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_1b9daa149b4790c306d4115e8498bce8e4004f87fdf8195a8bb15f493be69c40_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-33-4q3b\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605563652774398",
"status": "COMPLETED",
"status_changed_ts": "1605566875659606",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177737",
"builder:Linux Builder (dbg)",
"buildset:commit/git/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/259692674ef1b7ae6451910c714fb6340dbc1f9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028868276497371568",
"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/8863438213746307696/+/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:4febde7f437d3410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605566875665064",
"url": "https://ci.chromium.org/b/8863438213746307696",
"utcnow_ts": "1605566876423558"
}
}
[22:47:56.443] Invocation finished in 53m55.746208314s with status SUCCEEDED