[22:53:11.100] New invocation is queued and will start shortly
[22:53:12.183] Starting the invocation (attempt 1)
[22:53:12.214] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:53:12.215] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:53:12.215] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019623663072289760",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019623663072289760",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"gitiles_ref:refs/heads/master"
]
}
[22:53:13.107] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614379992348176",
"id": "8854193601101485600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614379992884659",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180970",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019623663072289760",
"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/8854193601101485600/+/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": "1614379992884846",
"url": "https://ci.chromium.org/b/8854193601101485600",
"utcnow_ts": "1614379993100627"
}
}
[22:53:13.107] Task URL: https://ci.chromium.org/b/8854193601101485600
[22:53:13.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:2:0) after 1m0s
[22:53:15.638] Received PubSub notification, asking Buildbucket for the build status
[22:53:15.797] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:2:0)
[22:54:13.137] Timer tick, asking Buildbucket for the build status
[22:54:13.219] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:4:0) after 1m0s
[22:55:13.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:4:0)
[22:55:13.228] Timer tick, asking Buildbucket for the build status
[22:55:13.390] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:5:0) after 1m0s
[22:56:13.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:5:0)
[22:56:13.404] Timer tick, asking Buildbucket for the build status
[22:56:13.574] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:13.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:6:0) after 1m0s
[22:57:13.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:6:0)
[22:57:13.623] Timer tick, asking Buildbucket for the build status
[22:57:13.713] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:13.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:7:0) after 1m0s
[22:58:13.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:7:0)
[22:58:13.739] Timer tick, asking Buildbucket for the build status
[22:58:13.886] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:13.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:8:0) after 1m0s
[22:59:13.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:8:0)
[22:59:13.950] Timer tick, asking Buildbucket for the build status
[22:59:14.194] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:9:0) after 1m0s
[23:00:14.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:9:0)
[23:00:14.215] Timer tick, asking Buildbucket for the build status
[23:00:14.324] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:14.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:10:0) after 1m0s
[23:01:14.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:10:0)
[23:01:14.343] Timer tick, asking Buildbucket for the build status
[23:01:14.420] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:14.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:11:0) after 1m0s
[23:02:14.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:11:0)
[23:02:14.437] Timer tick, asking Buildbucket for the build status
[23:02:14.501] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:14.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:12:0) after 1m0s
[23:03:14.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:12:0)
[23:03:14.538] Timer tick, asking Buildbucket for the build status
[23:03:14.633] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:14.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:13:0) after 1m0s
[23:04:14.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:13:0)
[23:04:14.802] Timer tick, asking Buildbucket for the build status
[23:04:14.922] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:14.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:14:0) after 1m0s
[23:05:15.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:14:0)
[23:05:15.073] Timer tick, asking Buildbucket for the build status
[23:05:15.151] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:15.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:15:0) after 1m0s
[23:06:15.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:15:0)
[23:06:15.175] Timer tick, asking Buildbucket for the build status
[23:06:16.646] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:16.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:16:0) after 1m0s
[23:07:16.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:16:0)
[23:07:16.722] Timer tick, asking Buildbucket for the build status
[23:07:16.805] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:16.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:17:0) after 1m0s
[23:08:16.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:17:0)
[23:08:16.852] Timer tick, asking Buildbucket for the build status
[23:08:17.086] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:17.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:18:0) after 1m0s
[23:09:17.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:18:0)
[23:09:17.200] Timer tick, asking Buildbucket for the build status
[23:09:17.268] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:17.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:19:0) after 1m0s
[23:10:17.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:19:0)
[23:10:17.281] Timer tick, asking Buildbucket for the build status
[23:10:17.389] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:17.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:20:0) after 1m0s
[23:11:17.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:20:0)
[23:11:17.436] Timer tick, asking Buildbucket for the build status
[23:11:17.637] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:17.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:21:0) after 1m0s
[23:12:17.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:21:0)
[23:12:17.667] Timer tick, asking Buildbucket for the build status
[23:12:19.437] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:19.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:22:0) after 1m0s
[23:13:19.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:22:0)
[23:13:19.437] Timer tick, asking Buildbucket for the build status
[23:13:19.927] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:19.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:23:0) after 1m0s
[23:14:19.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:23:0)
[23:14:19.948] Timer tick, asking Buildbucket for the build status
[23:14:20.024] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:20.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:24:0) after 1m0s
[23:15:20.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:24:0)
[23:15:20.056] Timer tick, asking Buildbucket for the build status
[23:15:20.263] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:20.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:25:0) after 1m0s
[23:16:20.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:25:0)
[23:16:20.321] Timer tick, asking Buildbucket for the build status
[23:16:20.418] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:20.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:26:0) after 1m0s
[23:17:20.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:26:0)
[23:17:20.447] Timer tick, asking Buildbucket for the build status
[23:17:20.523] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:20.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:27:0) after 1m0s
[23:18:20.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:27:0)
[23:18:20.575] Timer tick, asking Buildbucket for the build status
[23:18:20.680] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:20.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:28:0) after 1m0s
[23:19:20.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:28:0)
[23:19:20.715] Timer tick, asking Buildbucket for the build status
[23:19:20.780] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:20.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:29:0) after 1m0s
[23:20:20.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:29:0)
[23:20:20.774] Timer tick, asking Buildbucket for the build status
[23:20:20.843] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:20.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:30:0) after 1m0s
[23:21:20.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:30:0)
[23:21:20.850] Timer tick, asking Buildbucket for the build status
[23:21:21.210] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:21.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:31:0) after 1m0s
[23:22:21.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:31:0)
[23:22:21.309] Timer tick, asking Buildbucket for the build status
[23:22:21.385] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:21.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:32:0) after 1m0s
[23:23:21.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:32:0)
[23:23:21.441] Timer tick, asking Buildbucket for the build status
[23:23:21.528] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:21.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:33:0) after 1m0s
[23:24:21.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:33:0)
[23:24:21.524] Timer tick, asking Buildbucket for the build status
[23:24:21.601] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:21.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:34:0) after 1m0s
[23:25:21.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:34:0)
[23:25:21.639] Timer tick, asking Buildbucket for the build status
[23:25:21.721] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:21.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:35:0) after 1m0s
[23:26:21.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:35:0)
[23:26:21.704] Timer tick, asking Buildbucket for the build status
[23:26:21.775] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:21.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:36:0) after 1m0s
[23:27:21.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:36:0)
[23:27:21.793] Timer tick, asking Buildbucket for the build status
[23:27:21.859] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:37:0) after 1m0s
[23:28:21.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:37:0)
[23:28:21.896] Timer tick, asking Buildbucket for the build status
[23:28:22.028] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:22.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:38:0) after 1m0s
[23:29:22.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:38:0)
[23:29:22.078] Timer tick, asking Buildbucket for the build status
[23:29:22.277] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:22.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:39:0) after 1m0s
[23:30:22.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:39:0)
[23:30:22.360] Timer tick, asking Buildbucket for the build status
[23:30:22.450] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:22.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:40:0) after 1m0s
[23:31:22.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:40:0)
[23:31:22.448] Timer tick, asking Buildbucket for the build status
[23:31:22.527] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:22.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:41:0) after 1m0s
[23:32:22.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:41:0)
[23:32:22.575] Timer tick, asking Buildbucket for the build status
[23:32:22.666] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:22.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:42:0) after 1m0s
[23:33:22.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:42:0)
[23:33:22.635] Timer tick, asking Buildbucket for the build status
[23:33:22.767] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:43:0) after 1m0s
[23:34:22.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:43:0)
[23:34:22.837] Timer tick, asking Buildbucket for the build status
[23:34:22.921] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:22.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:44:0) after 1m0s
[23:35:22.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:44:0)
[23:35:22.938] Timer tick, asking Buildbucket for the build status
[23:35:23.084] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:45:0) after 1m0s
[23:36:23.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:45:0)
[23:36:23.127] Timer tick, asking Buildbucket for the build status
[23:36:23.493] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:23.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:46:0) after 1m0s
[23:37:23.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:46:0)
[23:37:23.614] Timer tick, asking Buildbucket for the build status
[23:37:23.700] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:47:0) after 1m0s
[23:38:23.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:47:0)
[23:38:23.753] Timer tick, asking Buildbucket for the build status
[23:38:24.097] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:24.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:48:0) after 1m0s
[23:39:24.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:48:0)
[23:39:24.212] Timer tick, asking Buildbucket for the build status
[23:39:24.292] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:49:0) after 1m0s
[23:40:24.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:49:0)
[23:40:24.371] Timer tick, asking Buildbucket for the build status
[23:40:24.437] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:24.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:50:0) after 1m0s
[23:41:24.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:50:0)
[23:41:24.430] Timer tick, asking Buildbucket for the build status
[23:41:24.619] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:24.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:51:0) after 1m0s
[23:42:24.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:51:0)
[23:42:24.673] Timer tick, asking Buildbucket for the build status
[23:42:24.875] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:24.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:52:0) after 1m0s
[23:43:25.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:52:0)
[23:43:25.021] Timer tick, asking Buildbucket for the build status
[23:43:25.116] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:25.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:53:0) after 1m0s
[23:44:25.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:53:0)
[23:44:25.114] Timer tick, asking Buildbucket for the build status
[23:44:25.183] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:25.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:54:0) after 1m0s
[23:45:25.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:54:0)
[23:45:25.194] Timer tick, asking Buildbucket for the build status
[23:45:25.259] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:25.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:55:0) after 1m0s
[23:46:25.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:55:0)
[23:46:25.381] Timer tick, asking Buildbucket for the build status
[23:46:25.552] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:25.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:56:0) after 1m0s
[23:47:25.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:56:0)
[23:47:25.551] Timer tick, asking Buildbucket for the build status
[23:47:25.661] Build 8854193601101485600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:25.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019623663072289760:57:0) after 1m0s
[23:48:01.357] Received PubSub notification, asking Buildbucket for the build status
[23:48:01.433] Build 8854193601101485600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:48:01.433] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614383279991389",
"created_by": "project:chromium",
"created_ts": "1614379992348176",
"id": "8854193601101485600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\"}}",
"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\": \"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\", \"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-172-x07d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180970, \"got_angle_revision\": \"33907625dbcaab89bb7f62abea53f40eb9488754\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\", \"got_revision_cp\": \"refs/heads/master@{#858315}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"6c0cc66c5647c8af90390f6670bc4e7ac91a1078\", \"swarm_hashes_refs/heads/master(at){#858315}_without_patch\": {\"absl_hardening_tests\": \"6541e7b9b431c1d1c86b14792875460b22259134\", \"accessibility_unittests\": \"e59e7f973ccba12326fb7a891fa13414d701a01d\", \"angle_unittests\": \"56b451a505326bf79d8bbfae66b1b748b05218e0\", \"app_shell_unittests\": \"a4b0b08012332b080257112f632a26c803f23773\", \"aura_unittests\": \"4b78a50875c7e75683c17f163098bac6f64c840d\", \"base_unittests\": \"850dbdd174f8a8ed946945324821a0ff9facadb6\", \"base_util_unittests\": \"7b44d527d6adf91d57b6a97889310e85d524fcde\", \"blink_common_unittests\": \"e6e244d3aed3431eff6e1507b28dbfc461eeb2b7\", \"blink_fuzzer_unittests\": \"d8014e44db8260754c0db09343b9bac3250c6a9e\", \"blink_heap_unittests\": \"dc1b20bedc12dccda037499af14a94f3dd0490ea\", \"blink_platform_unittests\": \"f6af0c85fb6296e3ea59dd83309f370ba3009a8b\", \"blink_python_tests\": \"c76b2c1d165598ce97575d37cd353ea1473aaf9c\", \"blink_unittests\": \"e21ab522c69de813735f9bf36be31af74e6aa5ba\", \"blink_web_tests\": \"d15d015dd5d1bdf155800bc5cb2fde9d0449aa12\", \"boringssl_crypto_tests\": \"4a4d28456fe2cb1ddff3973b78b096203005dad4\", \"boringssl_ssl_tests\": \"864c260220983c86e6184dabc1fd6d082c67f6eb\", \"browser_tests\": \"0ed861fbbd2ef8eee57ac9886cc5e50f909a1143\", \"capture_unittests\": \"2089cd87e98637756516118cf20b8d01a5e25002\", \"cast_unittests\": \"3df64b7638fecfaa1f035a242b86b60b605db9f7\", \"cc_unittests\": \"46afd961980ed9ca2d9f174c5c06a65330bca3f8\", \"chrome_app_unittests\": \"8236be63d8da7d2561477a381084d0dc32ecf9fe\", \"chromedriver_unittests\": \"b866aaa6c98fb84424e461fa5b6ae976a54808cd\", \"color_unittests\": \"40a8145267eae4aecc93e7745e5b604ec44b0550\", \"components_browsertests\": \"2eda347b91687a79e1a9e916d8e11de8ba0fc388\", \"components_unittests\": \"be5ef073b6243804fd1899bc35e2930c9cce9e4f\", \"compositor_unittests\": \"fa4a79b1120ff852a4a1faff94e6731b04bde6b5\", \"content_browsertests\": \"f15050d42031f838373028f18f1d4df45188460e\", \"content_shell_crash_test\": \"303a032c2cf1a010d9ac1045f37d55c4db81b761\", \"content_unittests\": \"abcb7b149fbae2714422785400e96565ab9f3ee5\", \"crashpad_tests\": \"42f6343cdfd8c499c08fc6d078056240eb542b73\", \"cronet_tests\": \"aeaecb3c038ad8525d45cd1ffccb445f6fdc4622\", \"cronet_unittests\": \"a0e0bf38cb86f30910399551beee74d95692aa4e\", \"crypto_unittests\": \"1dde50ee2916487c4f82ce7843b0d6ecaef091f7\", \"dbus_unittests\": \"65e7874c3a46c8c61b2556e82008b09a3611ef9e\", \"device_unittests\": \"6d2674c5e66f5a114003825e2737f3f81784d9c5\", \"display_unittests\": \"007f88a96e1de611474ecc57402a7486817ea27d\", \"events_unittests\": \"34d35df2ecbf4a0820426d9dfe24be300ceede3c\", \"extensions_browsertests\": \"73ee181bcc70b1ec3daab3bc0c6e41894382ad1a\", \"extensions_unittests\": \"dc0b38cbcefffc90f408b13f327a30188c715819\", \"filesystem_service_unittests\": \"68f3b6faaf397c96485bb26fe3f85b1ed9c34ff7\", \"flatbuffers_unittests\": \"b321573a6e379376cdf327a0c56c65611af14695\", \"gcm_unit_tests\": \"7fd5974923c7c961f3994dced3014421ae879a17\", \"gfx_unittests\": \"4616ccc9b0ebcd6c3565ba504e69fb9c11c64c36\", \"gin_unittests\": \"7e61fc0007266e12751fd59486016cef349680d6\", \"google_apis_unittests\": \"adcf5fca9ab5a6bff953e87208939a010a2c9604\", \"gpu_unittests\": \"e44e554178209a34d30e3378a8bea97c241d1376\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"474fbab3ddcc569edd179a4b3fe2efa1c9d9bc9f\", \"headless_browsertests\": \"3613a2ca85a11744c2fdb5fdaf21fc0c81ef17f2\", \"headless_unittests\": \"3c56556fb01baa32e57eb06355e57e866de06d62\", \"interactive_ui_tests\": \"dfe7400677b65026f08b1982133aa633c9cacbc1\", \"ipc_tests\": \"cb0c64129d811f95b4adca2a078c0222c4d4ed5b\", \"jingle_unittests\": \"ebc285f0dd7b328809b70459e42c71fba1576632\", \"latency_unittests\": \"fe72393497e4f5b8dc5d4583eb5229af55df3cec\", \"libjingle_xmpp_unittests\": \"25916adeaf210138f8a43c576d325fcab9d609cf\", \"liburlpattern_unittests\": \"1066738765d2164b95e5d217e2825ff253ea9305\", \"media_blink_unittests\": \"ce3f37c13a416a9ad1985c8f308dd3ebe12ccc97\", \"media_unittests\": \"04cf1870b7910029946fa117c992d3c780891acc\", \"message_center_unittests\": \"3580e28a7a9567a4ffab692a5d0d3fdcc2c4b915\", \"metrics_python_tests\": \"4a62e796250b57db364664551e688696b8652f94\", \"midi_unittests\": \"14248a41ba095ae9a8f9750f20eb7a57fc7d40dd\", \"mojo_core_unittests\": \"b9c93ae512469b36e10d457d43d5f269b2e7c920\", \"mojo_unittests\": \"d0178b8a8334a93e9c7a4c9c51e43e91b016ea14\", \"nacl_helper_nonsfi_unittests\": \"671a590d5eb1b38870573b679b3f1586f9c952eb\", \"nacl_loader_unittests\": \"d4e54a7c08203b5cdc7b2f41335d68359015038e\", \"native_theme_unittests\": \"55b1616984ebca838119577541b6a9896ff66a2d\", \"net_unittests\": \"3e1e33750bb221faa3b19ed04ea2d6e44e933067\", \"openscreen_unittests\": \"e0525cbd73a0fd78830549d36fe8ca09d8b698ef\", \"pdf_unittests\": \"0a42a1982db6d3d3d52dec4986389fa2c058c71c\", \"perfetto_unittests\": \"9a2af1bed15a3c7d2a6a6b6900e8613b88f6b09b\", \"ppapi_unittests\": \"12a160e7a06b1582a90926af68b65651531992c3\", \"printing_unittests\": \"a00958271e595414d82bd0b3b71b16e58d4866ce\", \"remoting_unittests\": \"11ee186d87b12150d2315966d32fabf7684cd934\", \"sandbox_linux_unittests\": \"4474e3b7a4544a655e1ea4b4211cae2a24ad3eb2\", \"service_manager_unittests\": \"8a954ad5e4bc0736eed24bd07e96e381afbfebf1\", \"services_unittests\": \"8f8bf60bbaa1648735cd0724c6c7475bc1a5ac3a\", \"shell_dialogs_unittests\": \"892df6d6d7749e3eea553b23e3a5dc8e230d72a5\", \"skia_unittests\": \"031de9f1ad82adf0d74bd024b7e0bcb8f3c1947f\", \"snapshot_unittests\": \"9add8c245ae865eab0f90aaf36c028d22182e3b4\", \"sql_unittests\": \"9f56197fe53644a970f02b719bd51108a57e1e14\", \"storage_unittests\": \"4f296865d63a669ac6aca40475c8d34d0076579e\", \"sync_integration_tests\": \"ffacebdee3f0c84a87e446e8f1bcd8ad5a39df3c\", \"telemetry_gpu_unittests\": \"c796f8ba1bc471866301d9475b9007dc14e3da7b\", \"telemetry_perf_unittests\": \"b61fcbec3ecb36fd761f7dc8f8d1d9255ce3e959\", \"telemetry_unittests\": \"a9badf885158ebaf51d3d562064dc7b428bfafd4\", \"traffic_annotation_auditor_unittests\": \"444946bd5bde800994b18ce0a07c71c7a12d66ef\", \"ui_base_unittests\": \"5e7dad3208e773597a3ef4b03dad730f2f0cf1cd\", \"ui_touch_selection_unittests\": \"30e4491e3ef94f60687c7fa5db879a323ba15e8b\", \"unit_tests\": \"8c1c502ab42031d8ed2e6a5c04b3d48383b66aab\", \"url_unittests\": \"3de453eb73926498ebc5545dfbf69636fdfd4459\", \"views_perftests\": \"d220a753a762952871c6d504d35ac8ecea0985de\", \"views_unittests\": \"f4ab0ee895289fed4c064515e69ee99c7561bab8\", \"viz_unittests\": \"9ccef0c878c29b3c369dbfc47abaa8db9ef1466d\", \"vr_common_unittests\": \"b021d9284bf83a02a6047066eba1bfdfea99454f\", \"vr_pixeltests\": \"f569b62e6a0e0b60895b028637d1e11b4562615c\", \"webdriver_wpt_tests\": \"0d2e91c98a8d3171d336a168488a4eac2aa56615\", \"weblayer_browsertests\": \"47d73260ebc7f0730388062fa5df6280c0203630\", \"weblayer_unittests\": \"844eddff2deef29a4f28dc721829de22432c40db\", \"wm_unittests\": \"ef6aaac68271bd35037c2a9708845db2a095f1be\", \"wtf_unittests\": \"d1ff404974e913ddb3d76a31852b8f17328f1393\", \"x11_unittests\": \"22ddf16e121d82172f74010542e1d53cc49ddf6f\", \"xr_browser_tests\": \"015526bca65f498b2a6084cfd16e3e454663492d\", \"zlib_unittests\": \"079255ff7a38116457544f7c2d4e567d8e7f9ef9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_be71ec2e45ff41f29ecdc3611cfb7c276cc0ff3138424d653aa2b7cfb51218d3_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-172-x07d\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614379994632887",
"status": "COMPLETED",
"status_changed_ts": "1614383280383801",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180970",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c0cc66c5647c8af90390f6670bc4e7ac91a1078",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019623663072289760",
"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/8854193601101485600/+/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:51f95d52baa38710",
"user_agent:luci-scheduler"
],
"updated_ts": "1614383280399384",
"url": "https://ci.chromium.org/b/8854193601101485600",
"utcnow_ts": "1614383281426794"
}
}
[23:48:01.433] Invocation finished in 54m50.348582981s with status SUCCEEDED