[06:31:16.922] New invocation is queued and will start shortly
[06:31:18.142] Starting the invocation (attempt 1)
[06:31:18.184] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:31:18.184] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:31:18.184] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022222154124617600",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b06db27d83197d791d2a3d320a8e540f53c4f67c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022222154124617600",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"gitiles_ref:refs/heads/master"
]
}
[06:31:18.793] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611901878308369",
"id": "8856792092009458992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b06db27d83197d791d2a3d320a8e540f53c4f67c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611901878678354",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180087",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022222154124617600",
"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/8856792092009458992/+/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": "1611901878678461",
"url": "https://ci.chromium.org/b/8856792092009458992",
"utcnow_ts": "1611901878786741"
}
}
[06:31:18.793] Task URL: https://ci.chromium.org/b/8856792092009458992
[06:31:18.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:2:0) after 1m0s
[06:31:29.641] Received PubSub notification, asking Buildbucket for the build status
[06:31:29.732] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:18.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:2:0)
[06:32:18.821] Timer tick, asking Buildbucket for the build status
[06:32:19.258] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:19.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:4:0) after 1m0s
[06:33:19.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:4:0)
[06:33:19.278] Timer tick, asking Buildbucket for the build status
[06:33:19.699] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:19.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:5:0) after 1m0s
[06:34:19.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:5:0)
[06:34:19.717] Timer tick, asking Buildbucket for the build status
[06:34:19.819] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:19.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:6:0) after 1m0s
[06:35:19.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:6:0)
[06:35:19.868] Timer tick, asking Buildbucket for the build status
[06:35:20.020] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:20.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:7:0) after 1m0s
[06:36:20.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:7:0)
[06:36:20.037] Timer tick, asking Buildbucket for the build status
[06:36:20.230] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:20.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:8:0) after 1m0s
[06:37:20.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:8:0)
[06:37:20.270] Timer tick, asking Buildbucket for the build status
[06:37:20.708] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:20.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:9:0) after 1m0s
[06:38:20.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:9:0)
[06:38:20.729] Timer tick, asking Buildbucket for the build status
[06:38:20.805] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:20.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:10:0) after 1m0s
[06:39:20.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:10:0)
[06:39:20.829] Timer tick, asking Buildbucket for the build status
[06:39:21.202] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:21.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:11:0) after 1m0s
[06:40:21.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:11:0)
[06:40:21.221] Timer tick, asking Buildbucket for the build status
[06:40:21.385] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:21.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:12:0) after 1m0s
[06:41:21.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:12:0)
[06:41:21.422] Timer tick, asking Buildbucket for the build status
[06:41:21.544] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:21.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:13:0) after 1m0s
[06:42:21.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:13:0)
[06:42:21.577] Timer tick, asking Buildbucket for the build status
[06:42:21.647] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:21.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:14:0) after 1m0s
[06:43:21.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:14:0)
[06:43:21.630] Timer tick, asking Buildbucket for the build status
[06:43:21.729] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:21.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:15:0) after 1m0s
[06:44:21.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:15:0)
[06:44:21.797] Timer tick, asking Buildbucket for the build status
[06:44:22.319] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:22.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:16:0) after 1m0s
[06:45:22.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:16:0)
[06:45:22.342] Timer tick, asking Buildbucket for the build status
[06:45:22.416] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:22.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:17:0) after 1m0s
[06:46:22.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:17:0)
[06:46:22.441] Timer tick, asking Buildbucket for the build status
[06:46:22.541] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:22.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:18:0) after 1m0s
[06:47:22.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:18:0)
[06:47:22.598] Timer tick, asking Buildbucket for the build status
[06:47:22.668] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:22.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:19:0) after 1m0s
[06:48:22.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:19:0)
[06:48:22.693] Timer tick, asking Buildbucket for the build status
[06:48:22.883] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:22.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:20:0) after 1m0s
[06:49:22.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:20:0)
[06:49:22.950] Timer tick, asking Buildbucket for the build status
[06:49:23.041] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:23.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:21:0) after 1m0s
[06:50:23.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:21:0)
[06:50:23.065] Timer tick, asking Buildbucket for the build status
[06:50:23.231] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:23.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:22:0) after 1m0s
[06:51:23.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:22:0)
[06:51:23.265] Timer tick, asking Buildbucket for the build status
[06:51:23.372] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:23.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:23:0) after 1m0s
[06:52:23.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:23:0)
[06:52:23.456] Timer tick, asking Buildbucket for the build status
[06:52:23.520] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:24:0) after 1m0s
[06:53:23.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:24:0)
[06:53:23.528] Timer tick, asking Buildbucket for the build status
[06:53:23.774] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:23.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:25:0) after 1m0s
[06:54:23.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:25:0)
[06:54:23.821] Timer tick, asking Buildbucket for the build status
[06:54:23.882] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:23.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:26:0) after 1m0s
[06:55:23.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:26:0)
[06:55:23.893] Timer tick, asking Buildbucket for the build status
[06:55:24.192] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:24.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:27:0) after 1m0s
[06:56:24.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:27:0)
[06:56:24.247] Timer tick, asking Buildbucket for the build status
[06:56:24.535] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:24.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:28:0) after 1m0s
[06:57:24.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:28:0)
[06:57:24.564] Timer tick, asking Buildbucket for the build status
[06:57:24.622] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:24.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:29:0) after 1m0s
[06:58:24.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:29:0)
[06:58:24.645] Timer tick, asking Buildbucket for the build status
[06:58:24.707] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:24.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:30:0) after 1m0s
[06:59:24.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:30:0)
[06:59:24.762] Timer tick, asking Buildbucket for the build status
[06:59:24.823] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:24.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:31:0) after 1m0s
[07:00:24.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:31:0)
[07:00:24.924] Timer tick, asking Buildbucket for the build status
[07:00:25.008] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:25.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:32:0) after 1m0s
[07:01:25.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:32:0)
[07:01:25.042] Timer tick, asking Buildbucket for the build status
[07:01:25.403] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:25.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:33:0) after 1m0s
[07:02:25.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:33:0)
[07:02:25.424] Timer tick, asking Buildbucket for the build status
[07:02:25.479] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:25.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:34:0) after 1m0s
[07:03:25.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:34:0)
[07:03:25.549] Timer tick, asking Buildbucket for the build status
[07:03:25.637] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:25.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:35:0) after 1m0s
[07:04:25.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:35:0)
[07:04:25.738] Timer tick, asking Buildbucket for the build status
[07:04:25.818] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:36:0) after 1m0s
[07:05:25.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:36:0)
[07:05:25.914] Timer tick, asking Buildbucket for the build status
[07:05:25.989] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:25.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:37:0) after 1m0s
[07:06:25.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:37:0)
[07:06:25.975] Timer tick, asking Buildbucket for the build status
[07:06:26.433] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:26.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:38:0) after 1m0s
[07:07:26.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:38:0)
[07:07:26.495] Timer tick, asking Buildbucket for the build status
[07:07:26.578] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:26.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:39:0) after 1m0s
[07:08:26.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:39:0)
[07:08:26.610] Timer tick, asking Buildbucket for the build status
[07:08:26.714] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:26.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:40:0) after 1m0s
[07:09:26.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:40:0)
[07:09:26.732] Timer tick, asking Buildbucket for the build status
[07:09:26.795] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:41:0) after 1m0s
[07:10:26.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:41:0)
[07:10:26.805] Timer tick, asking Buildbucket for the build status
[07:10:26.857] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:26.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:42:0) after 1m0s
[07:11:26.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:42:0)
[07:11:26.881] Timer tick, asking Buildbucket for the build status
[07:11:26.987] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:26.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:43:0) after 1m0s
[07:12:27.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:43:0)
[07:12:27.008] Timer tick, asking Buildbucket for the build status
[07:12:27.092] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:27.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:44:0) after 1m0s
[07:13:27.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:44:0)
[07:13:27.116] Timer tick, asking Buildbucket for the build status
[07:13:27.175] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:45:0) after 1m0s
[07:14:27.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:45:0)
[07:14:27.228] Timer tick, asking Buildbucket for the build status
[07:14:27.505] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:27.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:46:0) after 1m0s
[07:15:27.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:46:0)
[07:15:27.612] Timer tick, asking Buildbucket for the build status
[07:15:27.924] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:27.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:47:0) after 1m0s
[07:16:27.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:47:0)
[07:16:27.968] Timer tick, asking Buildbucket for the build status
[07:16:28.097] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:28.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:48:0) after 1m0s
[07:17:28.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:48:0)
[07:17:28.196] Timer tick, asking Buildbucket for the build status
[07:17:28.699] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:28.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:49:0) after 1m0s
[07:18:28.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:49:0)
[07:18:28.726] Timer tick, asking Buildbucket for the build status
[07:18:28.963] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:28.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:50:0) after 1m0s
[07:19:29.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:50:0)
[07:19:29.097] Timer tick, asking Buildbucket for the build status
[07:19:29.229] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:29.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:51:0) after 1m0s
[07:20:29.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:51:0)
[07:20:29.333] Timer tick, asking Buildbucket for the build status
[07:20:29.458] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:29.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:52:0) after 1m0s
[07:21:29.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:52:0)
[07:21:29.480] Timer tick, asking Buildbucket for the build status
[07:21:30.255] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:53:0) after 1m0s
[07:22:30.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:53:0)
[07:22:30.406] Timer tick, asking Buildbucket for the build status
[07:22:30.473] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:30.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:54:0) after 1m0s
[07:23:30.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:54:0)
[07:23:30.504] Timer tick, asking Buildbucket for the build status
[07:23:30.804] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:30.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:55:0) after 1m0s
[07:24:30.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:55:0)
[07:24:30.845] Timer tick, asking Buildbucket for the build status
[07:24:30.941] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:30.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:56:0) after 1m0s
[07:25:30.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:56:0)
[07:25:30.983] Timer tick, asking Buildbucket for the build status
[07:25:33.045] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:33.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:57:0) after 1m0s
[07:26:33.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:57:0)
[07:26:33.217] Timer tick, asking Buildbucket for the build status
[07:26:33.393] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:33.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:58:0) after 1m0s
[07:27:33.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:58:0)
[07:27:33.437] Timer tick, asking Buildbucket for the build status
[07:27:33.510] Build 8856792092009458992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:33.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022222154124617600:59:0) after 1m0s
[07:28:09.835] Received PubSub notification, asking Buildbucket for the build status
[07:28:10.310] Build 8856792092009458992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:28:10.310] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611905288797607",
"created_by": "project:chromium",
"created_ts": "1611901878308369",
"id": "8856792092009458992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b06db27d83197d791d2a3d320a8e540f53c4f67c\"}}",
"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\": \"b06db27d83197d791d2a3d320a8e540f53c4f67c\", \"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-east1-d-8-55-zgbv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180087, \"got_angle_revision\": \"e419222d82cff7286ccc368932bf0fbb5d31d9e9\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"b06db27d83197d791d2a3d320a8e540f53c4f67c\", \"got_revision_cp\": \"refs/heads/master@{#848427}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"b06db27d83197d791d2a3d320a8e540f53c4f67c\", \"swarm_hashes_refs/heads/master(at){#848427}_without_patch\": {\"absl_hardening_tests\": \"9537a88b7915508873f36c9c59a4c1866a75ae53\", \"accessibility_unittests\": \"ae67e26366912419715c7aa1916e16090d1a8ffb\", \"angle_unittests\": \"2494b2071d75df317fbeb1c91926103dd0bf5085\", \"app_shell_unittests\": \"ae7c45210129dae6562e562f0eaaf5b65f26eaab\", \"aura_unittests\": \"143318497bdc4ee8c25026d6a9eeeedc658eca01\", \"base_unittests\": \"fda27f45e3bfa3f32b0b9590d93601df3ab7aa1e\", \"base_util_unittests\": \"2911fcea3ca26cf08ce58e38ec591341eeb43f80\", \"blink_common_unittests\": \"5d3b5c6b787232d6036e1fe15dac57d379ec6b08\", \"blink_fuzzer_unittests\": \"fcbe91102574273a5179a8a0fec9a466b4cc90e3\", \"blink_heap_unittests\": \"019d63fbce6d73a0c2b1445192a30c9a2d28bcd0\", \"blink_platform_unittests\": \"50866c44f115fd5f5e6a2808cb6abbf3ffdbb89d\", \"blink_python_tests\": \"c9741d24d700fd358d62e40e5974eab0d4d39792\", \"blink_unittests\": \"d529876ff6f3a17a24442b6c3e6efafbcbce1e6c\", \"blink_web_tests\": \"9d12c7c762259912eaaf853829269bfc04240c27\", \"boringssl_crypto_tests\": \"03d86580fead64398d62dfda13739f44c72cb154\", \"boringssl_ssl_tests\": \"9e3238c5fe764864c95cc7e89888be279e3f704a\", \"browser_tests\": \"ece57fd350689a35be431bfd94dea061b1434b81\", \"capture_unittests\": \"b72c177842140b9dff513a95fa90ad4839eb59e9\", \"cast_unittests\": \"fcf0a35eaea216fa0d3d6bdf3d03c1dea1c40582\", \"cc_unittests\": \"6b6a1579ea62dc33f1ee619335fbf7f896d2f2ff\", \"chrome_app_unittests\": \"1d603935e0bd72d84f4c3ce389a6ef0fd47c3c3b\", \"chromedriver_unittests\": \"18d4e23128abdd8601a04cf2368faf26423a5c6f\", \"components_browsertests\": \"5dcc2f5bb013a72e4ac016c56ddb19c15432ebf6\", \"components_unittests\": \"f68840bb79073156023a9eb8988cd2af050b2f38\", \"compositor_unittests\": \"1adda9dd415598a1571ec141d615ce2d0602f033\", \"content_browsertests\": \"c750e3573a56aff3b00ad41e6bbf55e94261cfa9\", \"content_shell_crash_test\": \"4d1eb315a1c26958b43679f371620ee97b05c520\", \"content_unittests\": \"270eda20ce556ec9f7b49b726b5d20b2497d9bd7\", \"crashpad_tests\": \"f22d3aab0815165c84623a3d4b390eebed6ba893\", \"cronet_tests\": \"b4795e512e6bd2225b113a6035ac79f567097728\", \"cronet_unittests\": \"fe8bc0207969b913eccf1ab18f7292174d712cf2\", \"crypto_unittests\": \"5af6ea183abf07b611c3160bef3b434007e02b45\", \"dbus_unittests\": \"4af4d725c090719274e71c3e651b80e8d1ffa99f\", \"device_unittests\": \"786eb90bccdffcee1d7f00848c36d4327a002059\", \"display_unittests\": \"5f5c3e552a7a07009e913aac706db3acda390dc2\", \"events_unittests\": \"9ae3a355809b2a39dacb0418e7da2235a4607b4e\", \"extensions_browsertests\": \"0a50e0a59435508ac1fcbd09ba1195945a904f91\", \"extensions_unittests\": \"e4a5c83b6b59c47026d95b495453908c02fc66c0\", \"filesystem_service_unittests\": \"1b97569b4cf01b9a3a3ff501974bac3fc05632ad\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"4814d9e4cfdb3e0a1e33c8e9c3af17ae055aad9b\", \"gfx_unittests\": \"0645ef0d5101b12f31aabc31d25e36e4a9da7e81\", \"gin_unittests\": \"d8cc804601c9e4449d4594861fa193da3d770005\", \"google_apis_unittests\": \"23b5f4af8beb57dafbe10c6e673340c0eb8c5f5e\", \"gpu_unittests\": \"d001f19c26f0de5e840e0654fe24619d199de26c\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"4e379c85e4667181062c7dc3f84420e6faa40bc6\", \"headless_browsertests\": \"f81b06bd615f85dfbcb4f8a35282d89743564345\", \"headless_unittests\": \"68b3fb8948d4ca128ff1b6a292e796a9c291e622\", \"interactive_ui_tests\": \"e809593ba8c3ce2f71a033199a042964e30cc99b\", \"ipc_tests\": \"bb730f35f146a7e218d6eda8d29b67c0db18af7b\", \"jingle_unittests\": \"33c5d05d9fe2009f9269e3cf448a7e00f613979a\", \"latency_unittests\": \"0ab16a1104da4f09cf864fcae281659156daa3a2\", \"libjingle_xmpp_unittests\": \"b929224ffe402a9f3b66ebb39ef6c419d1e8a14c\", \"liburlpattern_unittests\": \"fb50d59f480ab3d5988d8a7e0bcf6656bfcf422a\", \"media_blink_unittests\": \"7a715902c79c1c060565820117992f583987d600\", \"media_unittests\": \"2b82f14f1b51fb4946de28ea4b50203069f8d5d9\", \"message_center_unittests\": \"4d31cf88c1d94ad819ef7fa27786141f9eb2365e\", \"metrics_python_tests\": \"9425159c8eddde4719ab7347e77d597745b2688c\", \"midi_unittests\": \"09028d3599785cee89bf890c39c615d71eb06fb1\", \"mojo_core_unittests\": \"c7bbe9d62d022c810b968699a8ca58076e561a48\", \"mojo_unittests\": \"2e770bc7c2da8c6728057987c851831331d89689\", \"nacl_helper_nonsfi_unittests\": \"799d61310acb5281d89f7238b87c48c0f4c9508e\", \"nacl_loader_unittests\": \"87c45c337182efa31971d4b0ff960166180fdf9c\", \"native_theme_unittests\": \"3eb0d5f10d3cf0956d9ba85d8e976f366013fe76\", \"net_unittests\": \"1807e3f61861364bc11de2e42eacaf0ee5b33a36\", \"openscreen_unittests\": \"3ed91c3fb75e6b9948d2a91e4440eb88d21b8a96\", \"pdf_unittests\": \"a086c3fa9f4f52ceb6876b3d95e00a79a4765709\", \"perfetto_unittests\": \"2d15f390882fca65735acab2e6f02c798e0e99de\", \"ppapi_unittests\": \"2f4632e75ecfb8e7f1460f1277ba5250489fbc22\", \"printing_unittests\": \"0c01db23d6a9107b4da50012f529f793ba08e7a8\", \"remoting_unittests\": \"41d091d2262facc2b4c2498349b388342a99956d\", \"sandbox_linux_unittests\": \"295c02ae18d2406f3989e6b7c04e5378fb5b6738\", \"service_manager_unittests\": \"adbafc51dca20873b663c00e22002b880576f758\", \"services_unittests\": \"5ad92b2e03eafff81db7b4aa65c385bf0f71a7f5\", \"shell_dialogs_unittests\": \"42d3bc270a2b357df6667e8522fc1da89e5c1218\", \"skia_unittests\": \"98bd9b0669e5f63a3564d1aa2a3f2cb1ddd43657\", \"snapshot_unittests\": \"57b391378f8300726e9f72b901b39fd6942189b6\", \"sql_unittests\": \"17bce550fa196da455d0ae462590f710fe3fa96c\", \"storage_unittests\": \"0cf87d0fa458a9b5dc369a127a8798cf7e8bfcdb\", \"sync_integration_tests\": \"b430992ef0ac90b3a513d87516365a7b0ff40022\", \"telemetry_gpu_unittests\": \"34d8c9ab2a125b2232b8969538293348d661f340\", \"telemetry_perf_unittests\": \"5f5ace622f8abef50d3cdc05e66e4fb9c9856b00\", \"telemetry_unittests\": \"db5c0f2b009f1d9a043b8a3a3b5a35d7a2c685b1\", \"traffic_annotation_auditor_unittests\": \"2ca80a43e647676cbddb958a1f06745580ff144b\", \"ui_base_unittests\": \"4789e653eb2b3046496dc61275c2497b4430f8f1\", \"ui_touch_selection_unittests\": \"8ca8b301ef8668553e853fb82de189d3262ddcb3\", \"unit_tests\": \"edb1658403e038ab489c94911cbdcc2d745a243d\", \"url_unittests\": \"53f114a0ff3c0c3b6820396aadca30309fa041d8\", \"views_perftests\": \"8d60946ca8af0e08918b2110694d0e0ad73fa507\", \"views_unittests\": \"c06efae11814748030e2752a265217a3b5eb16e0\", \"viz_unittests\": \"baa1ecbeab5740d2decec5662dda9f16d5ec4c0a\", \"vr_common_unittests\": \"8a2079a3accd6a2c078124a6f688451ee8ba94c9\", \"vr_pixeltests\": \"1cfeddc3902cafd6a6fcf136ae2675795db5f4e9\", \"webdriver_wpt_tests\": \"80c18110a1d2d9159849afc5c4463ea3cdeb9a79\", \"weblayer_browsertests\": \"98ed413110e84db6995f8ee1b6dd59fd79ec7490\", \"weblayer_unittests\": \"10bd9cea3f68bb8acc26d1d563481ca365f4b353\", \"wm_unittests\": \"0fc03cd66bb913b5cf365ae72c23a9f40ab5209f\", \"wtf_unittests\": \"922c8dfb1eb5973c504f108d266d50390eb5958f\", \"x11_unittests\": \"d4d944b7d8f46ab193b2bbad33b053f2fd922c6e\", \"xr_browser_tests\": \"a1585cdd76d5e8c24d8d4dd269b43f80696b0a11\", \"zlib_unittests\": \"63e56111245e24b0930ac2cce9f174b8969e8ac4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-east1-d-8-55-zgbv\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611901888615537",
"status": "COMPLETED",
"status_changed_ts": "1611905289282806",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180087",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b06db27d83197d791d2a3d320a8e540f53c4f67c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022222154124617600",
"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/8856792092009458992/+/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:5165a84a83c50d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611905289287158",
"url": "https://ci.chromium.org/b/8856792092009458992",
"utcnow_ts": "1611905290291115"
}
}
[07:28:10.310] Invocation finished in 56m53.40312257s with status SUCCEEDED