[23:02:07.328] New invocation is queued and will start shortly
[23:02:09.078] Starting the invocation (attempt 1)
[23:02:09.118] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:02:09.118] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:02:09.118] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021888024965322208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2ab55b52e5041aa459ffd2a0584eb035b646149d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021888024965322208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"gitiles_ref:refs/heads/master"
]
}
[23:02:10.042] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612220529212797",
"id": "8856457962318969616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2ab55b52e5041aa459ffd2a0584eb035b646149d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612220529826447",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180178",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021888024965322208",
"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/8856457962318969616/+/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": "1612220529826616",
"url": "https://ci.chromium.org/b/8856457962318969616",
"utcnow_ts": "1612220530018601"
}
}
[23:02:10.042] Task URL: https://ci.chromium.org/b/8856457962318969616
[23:02:10.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:2:0) after 1m0s
[23:02:13.736] Received PubSub notification, asking Buildbucket for the build status
[23:02:13.938] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:10.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:2:0)
[23:03:10.123] Timer tick, asking Buildbucket for the build status
[23:03:10.244] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:10.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:4:0) after 1m0s
[23:04:10.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:4:0)
[23:04:10.303] Timer tick, asking Buildbucket for the build status
[23:04:10.593] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:10.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:5:0) after 1m0s
[23:05:10.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:5:0)
[23:05:10.665] Timer tick, asking Buildbucket for the build status
[23:05:11.170] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:11.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:6:0) after 1m0s
[23:06:11.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:6:0)
[23:06:11.205] Timer tick, asking Buildbucket for the build status
[23:06:12.344] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:12.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:7:0) after 1m0s
[23:07:12.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:7:0)
[23:07:12.425] Timer tick, asking Buildbucket for the build status
[23:07:12.668] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:12.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:8:0) after 1m0s
[23:08:12.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:8:0)
[23:08:12.654] Timer tick, asking Buildbucket for the build status
[23:08:12.734] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:12.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:9:0) after 1m0s
[23:09:12.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:9:0)
[23:09:12.902] Timer tick, asking Buildbucket for the build status
[23:09:12.962] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:12.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:10:0) after 1m0s
[23:10:12.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:10:0)
[23:10:12.993] Timer tick, asking Buildbucket for the build status
[23:10:13.092] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:13.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:11:0) after 1m0s
[23:11:13.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:11:0)
[23:11:13.178] Timer tick, asking Buildbucket for the build status
[23:11:13.257] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:13.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:12:0) after 1m0s
[23:12:13.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:12:0)
[23:12:13.407] Timer tick, asking Buildbucket for the build status
[23:12:13.917] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:13.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:13:0) after 1m0s
[23:13:13.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:13:0)
[23:13:13.953] Timer tick, asking Buildbucket for the build status
[23:13:14.064] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:14.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:14:0) after 1m0s
[23:14:14.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:14:0)
[23:14:14.099] Timer tick, asking Buildbucket for the build status
[23:14:14.214] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:14.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:15:0) after 1m0s
[23:15:14.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:15:0)
[23:15:14.286] Timer tick, asking Buildbucket for the build status
[23:15:14.474] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:14.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:16:0) after 1m0s
[23:16:14.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:16:0)
[23:16:14.534] Timer tick, asking Buildbucket for the build status
[23:16:14.623] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:14.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:17:0) after 1m0s
[23:17:14.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:17:0)
[23:17:14.651] Timer tick, asking Buildbucket for the build status
[23:17:14.786] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:14.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:18:0) after 1m0s
[23:18:14.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:18:0)
[23:18:14.770] Timer tick, asking Buildbucket for the build status
[23:18:15.451] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:15.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:19:0) after 1m0s
[23:19:15.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:19:0)
[23:19:15.449] Timer tick, asking Buildbucket for the build status
[23:19:15.510] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:15.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:20:0) after 1m0s
[23:20:15.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:20:0)
[23:20:15.591] Timer tick, asking Buildbucket for the build status
[23:20:15.648] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:15.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:21:0) after 1m0s
[23:21:15.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:21:0)
[23:21:15.673] Timer tick, asking Buildbucket for the build status
[23:21:15.808] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:15.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:22:0) after 1m0s
[23:22:15.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:22:0)
[23:22:15.846] Timer tick, asking Buildbucket for the build status
[23:22:15.980] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:15.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:23:0) after 1m0s
[23:23:15.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:23:0)
[23:23:15.999] Timer tick, asking Buildbucket for the build status
[23:23:16.456] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:16.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:24:0) after 1m0s
[23:24:16.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:24:0)
[23:24:16.488] Timer tick, asking Buildbucket for the build status
[23:24:16.863] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:16.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:25:0) after 1m0s
[23:25:16.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:25:0)
[23:25:16.861] Timer tick, asking Buildbucket for the build status
[23:25:16.936] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:26:0) after 1m0s
[23:26:16.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:26:0)
[23:26:16.957] Timer tick, asking Buildbucket for the build status
[23:26:17.341] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:17.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:27:0) after 1m0s
[23:27:17.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:27:0)
[23:27:17.362] Timer tick, asking Buildbucket for the build status
[23:27:17.826] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:17.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:28:0) after 1m0s
[23:28:17.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:28:0)
[23:28:17.866] Timer tick, asking Buildbucket for the build status
[23:28:17.953] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:17.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:29:0) after 1m0s
[23:29:17.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:29:0)
[23:29:17.971] Timer tick, asking Buildbucket for the build status
[23:29:18.107] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:18.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:30:0) after 1m0s
[23:30:18.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:30:0)
[23:30:18.137] Timer tick, asking Buildbucket for the build status
[23:30:18.210] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:18.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:31:0) after 1m0s
[23:31:18.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:31:0)
[23:31:18.239] Timer tick, asking Buildbucket for the build status
[23:31:18.308] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:18.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:32:0) after 1m0s
[23:32:18.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:32:0)
[23:32:18.365] Timer tick, asking Buildbucket for the build status
[23:32:18.460] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:18.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:33:0) after 1m0s
[23:33:18.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:33:0)
[23:33:18.516] Timer tick, asking Buildbucket for the build status
[23:33:18.678] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:18.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:34:0) after 1m0s
[23:34:18.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:34:0)
[23:34:18.809] Timer tick, asking Buildbucket for the build status
[23:34:18.871] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:18.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:35:0) after 1m0s
[23:35:18.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:35:0)
[23:35:18.937] Timer tick, asking Buildbucket for the build status
[23:35:19.191] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:19.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:36:0) after 1m0s
[23:36:19.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:36:0)
[23:36:19.175] Timer tick, asking Buildbucket for the build status
[23:36:19.403] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:19.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:37:0) after 1m0s
[23:37:19.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:37:0)
[23:37:19.503] Timer tick, asking Buildbucket for the build status
[23:37:20.062] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:38:0) after 1m0s
[23:38:20.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:38:0)
[23:38:20.094] Timer tick, asking Buildbucket for the build status
[23:38:21.293] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:21.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:39:0) after 1m0s
[23:39:21.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:39:0)
[23:39:21.338] Timer tick, asking Buildbucket for the build status
[23:39:21.425] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:21.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:40:0) after 1m0s
[23:40:21.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:40:0)
[23:40:21.485] Timer tick, asking Buildbucket for the build status
[23:40:22.103] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:22.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:41:0) after 1m0s
[23:41:22.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:41:0)
[23:41:22.122] Timer tick, asking Buildbucket for the build status
[23:41:22.186] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:22.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:42:0) after 1m0s
[23:42:22.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:42:0)
[23:42:22.215] Timer tick, asking Buildbucket for the build status
[23:42:22.328] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:22.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:43:0) after 1m0s
[23:43:22.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:43:0)
[23:43:22.351] Timer tick, asking Buildbucket for the build status
[23:43:22.411] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:22.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:44:0) after 1m0s
[23:44:22.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:44:0)
[23:44:22.484] Timer tick, asking Buildbucket for the build status
[23:44:22.577] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:22.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:45:0) after 1m0s
[23:45:22.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:45:0)
[23:45:22.654] Timer tick, asking Buildbucket for the build status
[23:45:22.760] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:22.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:46:0) after 1m0s
[23:46:22.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:46:0)
[23:46:22.782] Timer tick, asking Buildbucket for the build status
[23:46:22.832] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:22.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:47:0) after 1m0s
[23:47:22.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:47:0)
[23:47:22.830] Timer tick, asking Buildbucket for the build status
[23:47:22.939] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:22.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:48:0) after 1m0s
[23:48:22.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:48:0)
[23:48:22.925] Timer tick, asking Buildbucket for the build status
[23:48:23.063] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:23.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:49:0) after 1m0s
[23:49:23.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:49:0)
[23:49:23.073] Timer tick, asking Buildbucket for the build status
[23:49:23.175] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:23.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:50:0) after 1m0s
[23:50:23.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:50:0)
[23:50:23.202] Timer tick, asking Buildbucket for the build status
[23:50:23.262] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:23.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:51:0) after 1m0s
[23:51:23.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:51:0)
[23:51:23.643] Timer tick, asking Buildbucket for the build status
[23:51:23.974] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:23.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:52:0) after 1m0s
[23:52:24.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:52:0)
[23:52:24.123] Timer tick, asking Buildbucket for the build status
[23:52:24.218] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:24.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:53:0) after 1m0s
[23:53:24.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:53:0)
[23:53:24.455] Timer tick, asking Buildbucket for the build status
[23:53:24.515] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:54:0) after 1m0s
[23:54:24.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:54:0)
[23:54:24.570] Timer tick, asking Buildbucket for the build status
[23:54:24.829] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:24.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:55:0) after 1m0s
[23:55:24.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:55:0)
[23:55:24.914] Timer tick, asking Buildbucket for the build status
[23:55:25.342] Build 8856457962318969616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:25.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021888024965322208:56:0) after 1m0s
[23:56:10.147] Received PubSub notification, asking Buildbucket for the build status
[23:56:10.301] Build 8856457962318969616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:56:10.301] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612223769313911",
"created_by": "project:chromium",
"created_ts": "1612220529212797",
"id": "8856457962318969616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2ab55b52e5041aa459ffd2a0584eb035b646149d\"}}",
"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\": \"2ab55b52e5041aa459ffd2a0584eb035b646149d\", \"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-174-h5w3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180178, \"got_angle_revision\": \"0d175f30a81b75da39026d65637bd05a2d585f7a\", \"got_dawn_revision\": \"91e737b8f16a69600f6a391fff127facbdf9e7e0\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"2ab55b52e5041aa459ffd2a0584eb035b646149d\", \"got_revision_cp\": \"refs/heads/master@{#849311}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"5bc36e7aec3d7acdb0cb6bca02c0788d5993abbc\", \"got_v8_revision_cp\": \"refs/heads/9.0.106@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"2ab55b52e5041aa459ffd2a0584eb035b646149d\", \"swarm_hashes_refs/heads/master(at){#849311}_without_patch\": {\"absl_hardening_tests\": \"08f16b8c56bce3a3384945a98de97d0b5fff3724\", \"accessibility_unittests\": \"596d552d3f8ca17cbc654b40c21b2d036271eb6a\", \"angle_unittests\": \"e169f992814f7b330c52505619faf14426e6cfb5\", \"app_shell_unittests\": \"a1cab23564491e89daa9ebd31fe1466debe42711\", \"aura_unittests\": \"5c92ff69a9895717218a9a363042c1b23b5e357c\", \"base_unittests\": \"174ff463b1475f10bcf629c2ca2036c2daf4d32d\", \"base_util_unittests\": \"d390dfd7d151e00624c5af8b887c76779871856f\", \"blink_common_unittests\": \"cff9abdea06e5c4359a602e6c6ac61a098df6d0a\", \"blink_fuzzer_unittests\": \"c91a854a142c03d4bc83ac73b11dab41869dfd19\", \"blink_heap_unittests\": \"ff7319eba3ae2b6222c7c949f548144676035f25\", \"blink_platform_unittests\": \"6bada79504dc35229780baee34adf85f5b85484f\", \"blink_python_tests\": \"fdabcaf41815bc4830b79fb03527d0a9d87cee37\", \"blink_unittests\": \"bb680bd7a8d4a4994ea7a819060d648ee19fbe60\", \"blink_web_tests\": \"d5be2e602fbb6071de04ed76e1e16049385990c3\", \"boringssl_crypto_tests\": \"d7fc9f9280d2845a54caacb65a231cca9019a5f6\", \"boringssl_ssl_tests\": \"c0355406150d49049e18c5574ea08c0a75c02360\", \"browser_tests\": \"fa74e4281b73916e277d69202c40a9dce5aabafb\", \"capture_unittests\": \"ce59ffb8ba1cc9ede3c3156690f1ce9fb367ceeb\", \"cast_unittests\": \"7101c3ab97526e531e1f4e2dcbecd49ca61f9017\", \"cc_unittests\": \"eadb9ea40647a467f49fb851c7941f1c5611251d\", \"chrome_app_unittests\": \"8bfbeabb4a4fc2a570c7229d354904e9a914c772\", \"chromedriver_unittests\": \"a714db111b47d4b34d9e2c2c6a310d207307ba6a\", \"components_browsertests\": \"ce25b5d08859aff6f70704b40c8ff95f91ca603e\", \"components_unittests\": \"deac9da138905189336cf5efbcb0fb35b4d01bb3\", \"compositor_unittests\": \"1fdd5c5ea726afc009f0ca700849c2de6231c8dd\", \"content_browsertests\": \"4cca45a248565f52192f8e5e38e27ababcc6fc48\", \"content_shell_crash_test\": \"56d98ea449b34b4346fa2fd68f2169769458fb52\", \"content_unittests\": \"c6359d2c6b50673f8530e08083527eea636ad8e0\", \"crashpad_tests\": \"8c31f8a6b44fe3085d912e80cce3566c1ad5e2ab\", \"cronet_tests\": \"d58a33abf844f9c16c968beaeb9f2c89a6721982\", \"cronet_unittests\": \"6cee758441f29e5e3892318f086f839f95df32db\", \"crypto_unittests\": \"8afa4fc406d95674aab96db485a5f1f996e773b6\", \"dbus_unittests\": \"318b318a89787783d95ca90e9b15ef181a2fba41\", \"device_unittests\": \"d321f8f547618510c92e78cc6a72ebc08e6a9338\", \"display_unittests\": \"19d637f93784de9a3db194a698069d0d3ec2117a\", \"events_unittests\": \"804c4658bdda58aba379f1ea927a3a26b44635a6\", \"extensions_browsertests\": \"9bfd4cadc3432299a89c41ebf326dac7ed42aebe\", \"extensions_unittests\": \"4ce5615fa13f6c69945737da70b80678460b12aa\", \"filesystem_service_unittests\": \"938f7ac7916af0c3276139befd09ce64012a0f0a\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"4485ccc2b6d110af965e63b1882db7014f01e5ca\", \"gfx_unittests\": \"fa633f47dea8b63bb3ed57f60830a06c3901feb0\", \"gin_unittests\": \"40f66cf7a66996a6cca48aecea2ac980cdcf7a8f\", \"google_apis_unittests\": \"1b7af20a72a4e6e4e0680a5614d65fef02b3c305\", \"gpu_unittests\": \"94c848387c7d9b666e105bc7bc2d90a40504cc64\", \"grit_python_unittests\": \"13f3716d46ac6e381748ef5bf28b994edd24545a\", \"gwp_asan_unittests\": \"6d2c16a07900b56a75ba6163313e33044b15ab93\", \"headless_browsertests\": \"0539ab27c5fbe3e1410ea7dafd3e6b401400f976\", \"headless_unittests\": \"5701f066929a9c06104e3fab013e2c08004124c4\", \"interactive_ui_tests\": \"5fd3c22e05e7fe2552d6f04a602a63967a3ea7c2\", \"ipc_tests\": \"20de254431ae327a8cfc3334f89b09fb0eeae4ce\", \"jingle_unittests\": \"c33f4e55b961c051d505dbc805dcb7a79316e9f9\", \"latency_unittests\": \"6b1b7505df8f2da1bd10dfd58abbc36d39017397\", \"libjingle_xmpp_unittests\": \"af6998d8dce3d17c1c35bcf4d3a1f0e463d44c46\", \"liburlpattern_unittests\": \"a83f43b3cf59997d0cabfe4e594ba70836b4ca88\", \"media_blink_unittests\": \"6a5cc8d24a25a22521c19a1d0075e4a567fb2939\", \"media_unittests\": \"4f0a8a66db84103f58a0c13e02c5d86a39e393e3\", \"message_center_unittests\": \"c79ca6d8f96e747c08d8ae82901e22dc92c6e6cd\", \"metrics_python_tests\": \"74c748aaa50f96f7e011a2cb4fc971786d37b4b8\", \"midi_unittests\": \"632adebe37e9a6489a28daa64f675fe15b759a19\", \"mojo_core_unittests\": \"6e6de078b1a8feac6d4158d5670db45e05a9aec7\", \"mojo_unittests\": \"15f55c44c35291d80420b51d4049bf44a07bad65\", \"nacl_helper_nonsfi_unittests\": \"7052996918c3bbb6a5cbe45e86cd96629e379d43\", \"nacl_loader_unittests\": \"56866a6c41fc07f49744a6ba0fe9e059ae02a387\", \"native_theme_unittests\": \"a73a8835b5bb377dca24318d3e756825c02d7cad\", \"net_unittests\": \"35bfd09fd80395e79f79b2af0804231bb593591a\", \"openscreen_unittests\": \"94fa17885209bd501b1e5415b6cbea09531effbd\", \"pdf_unittests\": \"0ec9335c947470c2a7ef073f19d66708d3a55a3d\", \"perfetto_unittests\": \"f8857f412b05273f42e031c508784caded438802\", \"ppapi_unittests\": \"b488d2abd3918327e5a766cb545a1b2d194e9302\", \"printing_unittests\": \"1baa2692af4743906efbe1f9d2e5fe12024ae348\", \"remoting_unittests\": \"94641ff3cb1ca1cbf0078731966a66fcd19ab1da\", \"sandbox_linux_unittests\": \"3830fcfaad11b305fec5140c3d734e83ddd5735c\", \"service_manager_unittests\": \"8d2ae2a49a5e2019425381994041900d8adc9ee7\", \"services_unittests\": \"5111c29fa344fd9f3f67ad00cccb0028cec5c717\", \"shell_dialogs_unittests\": \"bd3c149cb7e7d7b23c1cb4b4826256f47011e8d7\", \"skia_unittests\": \"bc7b4984649bb967920dbb698dcb1ee030f39198\", \"snapshot_unittests\": \"2216207f27bb1f765afbfb7ba5e8c2a9ea9449b8\", \"sql_unittests\": \"0f6b271bcdf325e5b4db61680b1f01c12f73512a\", \"storage_unittests\": \"b7a16d7a33af413f3b72556558494a48a27ab68d\", \"sync_integration_tests\": \"40ce39ed1174e62ce76c437ff9250ddf0b1812d2\", \"telemetry_gpu_unittests\": \"77e0ba7b85d33586ad9bcab7d657168a1148f54f\", \"telemetry_perf_unittests\": \"74f043c03c4230c4012e4e8df06dded072ab07ef\", \"telemetry_unittests\": \"9b183b69a3ef7f0ddb59d3b0e5a88138ed46acc9\", \"traffic_annotation_auditor_unittests\": \"125f87cd5771f4d315c3b9a1347198c9f9259386\", \"ui_base_unittests\": \"5a76ead41c5787970e5b26aaf227b242b5836b1c\", \"ui_touch_selection_unittests\": \"24971c42d88fa3e7f87d9a667f92dd0639dcafc4\", \"unit_tests\": \"0f8b6f4bb1e2df5f6a53d6cf8509217cee4af4c0\", \"url_unittests\": \"c0df2cff1734e7376428f681077c265aa4c62d63\", \"views_perftests\": \"a0a3527af4f054d8c781411b80ec45862347afa4\", \"views_unittests\": \"810cd7b76f2500c699e2aed428fcbd12b3cf6df0\", \"viz_unittests\": \"f1a2c574db16086b6af1392cfc4ae95f61f266d4\", \"vr_common_unittests\": \"ed1e12691c19a680c16acf2c6ab830c3e3c53d37\", \"vr_pixeltests\": \"486e8ae9ce0b3e64832e9d129061afa284fe4b3e\", \"webdriver_wpt_tests\": \"9493e13ea78d279f333316a3fbbb994f667e5fb1\", \"weblayer_browsertests\": \"61620d4ae85058ab92f62143ecc16e8a2882bcc4\", \"weblayer_unittests\": \"e12b28c01ff7d35e20c87e6a1e46397eb7424019\", \"wm_unittests\": \"f9018e20b54a46a7134977358395048dddd91fc4\", \"wtf_unittests\": \"8441c03da5cd9098e4413b04953e9e0f0a2e374c\", \"x11_unittests\": \"ab46e06985b75105885c9c86d68918ee6b810479\", \"xr_browser_tests\": \"b2244480deb1b786cad8013cbd788cbbd702af06\", \"zlib_unittests\": \"b0155f950686ef6773eb4f25967e3738bcdfaab2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a72d480ca48f57bfd3a2a0028361f62534d8cf527dbb841fd2259fc00e36dedb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_ea4e7feff896b82ff6619a3b9c5371d5e74ebdd508befd295e2f5ab02f5eefaf_v2\", \"builder_eb75bb97ad9a82e6e51bc242be3605b13562b7c1ffaba99d94159b9b70e03009_v2\", \"builder_f950d00180feebb913a151f4148df44a669def32bdb4d2b9a63ead64ebacc911_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-174-h5w3\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612220532275310",
"status": "COMPLETED",
"status_changed_ts": "1612223769742819",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180178",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ab55b52e5041aa459ffd2a0584eb035b646149d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021888024965322208",
"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/8856457962318969616/+/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:5178a687fc42ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612223769748376",
"url": "https://ci.chromium.org/b/8856457962318969616",
"utcnow_ts": "1612223770251908"
}
}
[23:56:10.301] Invocation finished in 54m2.996109196s with status SUCCEEDED