[16:53:05.903] New invocation is queued and will start shortly
[16:53:07.078] Starting the invocation (attempt 1)
[16:53:07.158] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:53:07.158] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:53:07.159] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021095869228464864",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c419a57d6f1ca3fc5cbec7850bbe707016412a48\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021095869228464864",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"gitiles_ref:refs/heads/master"
]
}
[16:53:08.770] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612975987306814",
"id": "8855665807093183328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c419a57d6f1ca3fc5cbec7850bbe707016412a48\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612975988350393",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180462",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021095869228464864",
"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/8855665807093183328/+/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": "1612975988350511",
"url": "https://ci.chromium.org/b/8855665807093183328",
"utcnow_ts": "1612975988753648"
}
}
[16:53:08.770] Task URL: https://ci.chromium.org/b/8855665807093183328
[16:53:08.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:2:0) after 1m0s
[16:53:11.899] Received PubSub notification, asking Buildbucket for the build status
[16:53:12.033] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:08.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:2:0)
[16:54:08.797] Timer tick, asking Buildbucket for the build status
[16:54:09.101] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:09.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:4:0) after 1m0s
[16:55:09.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:4:0)
[16:55:09.123] Timer tick, asking Buildbucket for the build status
[16:55:09.228] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:09.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:5:0) after 1m0s
[16:56:09.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:5:0)
[16:56:09.296] Timer tick, asking Buildbucket for the build status
[16:56:10.158] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:10.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:6:0) after 1m0s
[16:57:10.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:6:0)
[16:57:10.188] Timer tick, asking Buildbucket for the build status
[16:57:10.532] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:10.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:7:0) after 1m0s
[16:58:10.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:7:0)
[16:58:10.555] Timer tick, asking Buildbucket for the build status
[16:58:10.799] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:10.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:8:0) after 1m0s
[16:59:10.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:8:0)
[16:59:10.961] Timer tick, asking Buildbucket for the build status
[16:59:11.520] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:11.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:9:0) after 1m0s
[17:00:11.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:9:0)
[17:00:11.597] Timer tick, asking Buildbucket for the build status
[17:00:12.189] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:12.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:10:0) after 1m0s
[17:01:12.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:10:0)
[17:01:12.334] Timer tick, asking Buildbucket for the build status
[17:01:12.765] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:12.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:11:0) after 1m0s
[17:02:12.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:11:0)
[17:02:12.903] Timer tick, asking Buildbucket for the build status
[17:02:13.905] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:13.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:12:0) after 1m0s
[17:03:13.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:12:0)
[17:03:13.923] Timer tick, asking Buildbucket for the build status
[17:03:14.987] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:14.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:13:0) after 1m0s
[17:04:15.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:13:0)
[17:04:15.030] Timer tick, asking Buildbucket for the build status
[17:04:15.254] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:15.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:14:0) after 1m0s
[17:05:15.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:14:0)
[17:05:15.328] Timer tick, asking Buildbucket for the build status
[17:05:15.545] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:15:0) after 1m0s
[17:06:15.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:15:0)
[17:06:15.608] Timer tick, asking Buildbucket for the build status
[17:06:15.858] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:16:0) after 1m0s
[17:07:16.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:16:0)
[17:07:16.044] Timer tick, asking Buildbucket for the build status
[17:07:16.135] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:16.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:17:0) after 1m0s
[17:08:16.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:17:0)
[17:08:16.201] Timer tick, asking Buildbucket for the build status
[17:08:16.396] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:18:0) after 1m0s
[17:09:16.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:18:0)
[17:09:16.452] Timer tick, asking Buildbucket for the build status
[17:09:17.241] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:17.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:19:0) after 1m0s
[17:10:17.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:19:0)
[17:10:17.277] Timer tick, asking Buildbucket for the build status
[17:10:17.775] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:17.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:20:0) after 1m0s
[17:11:17.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:20:0)
[17:11:17.800] Timer tick, asking Buildbucket for the build status
[17:11:18.035] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:18.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:21:0) after 1m0s
[17:12:18.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:21:0)
[17:12:18.033] Timer tick, asking Buildbucket for the build status
[17:12:18.132] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:18.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:22:0) after 1m0s
[17:13:18.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:22:0)
[17:13:18.180] Timer tick, asking Buildbucket for the build status
[17:13:18.303] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:18.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:23:0) after 1m0s
[17:14:18.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:23:0)
[17:14:18.369] Timer tick, asking Buildbucket for the build status
[17:14:18.720] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:18.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:24:0) after 1m0s
[17:15:18.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:24:0)
[17:15:18.995] Timer tick, asking Buildbucket for the build status
[17:15:19.422] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:19.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:25:0) after 1m0s
[17:16:19.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:25:0)
[17:16:19.702] Timer tick, asking Buildbucket for the build status
[17:16:20.007] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:20.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:26:0) after 1m0s
[17:17:20.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:26:0)
[17:17:20.057] Timer tick, asking Buildbucket for the build status
[17:17:20.438] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:20.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:27:0) after 1m0s
[17:18:20.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:27:0)
[17:18:20.617] Timer tick, asking Buildbucket for the build status
[17:18:20.804] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:20.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:28:0) after 1m0s
[17:19:20.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:28:0)
[17:19:20.948] Timer tick, asking Buildbucket for the build status
[17:19:21.211] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:21.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:29:0) after 1m0s
[17:20:21.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:29:0)
[17:20:21.266] Timer tick, asking Buildbucket for the build status
[17:20:21.601] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:21.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:30:0) after 1m0s
[17:21:22.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:30:0)
[17:21:22.330] Timer tick, asking Buildbucket for the build status
[17:21:22.652] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:22.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:31:0) after 1m0s
[17:22:22.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:31:0)
[17:22:22.972] Timer tick, asking Buildbucket for the build status
[17:22:23.433] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:32:0) after 1m0s
[17:23:23.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:32:0)
[17:23:23.563] Timer tick, asking Buildbucket for the build status
[17:23:24.111] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:33:0) after 1m0s
[17:24:24.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:33:0)
[17:24:24.451] Timer tick, asking Buildbucket for the build status
[17:24:24.561] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:24.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:34:0) after 1m0s
[17:25:24.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:34:0)
[17:25:24.848] Timer tick, asking Buildbucket for the build status
[17:25:25.305] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:25.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:35:0) after 1m0s
[17:26:25.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:35:0)
[17:26:25.404] Timer tick, asking Buildbucket for the build status
[17:26:26.235] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:26.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:36:0) after 1m0s
[17:27:26.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:36:0)
[17:27:26.672] Timer tick, asking Buildbucket for the build status
[17:27:26.816] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:26.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:37:0) after 1m0s
[17:28:27.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:37:0)
[17:28:27.053] Timer tick, asking Buildbucket for the build status
[17:28:27.530] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:27.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:38:0) after 1m0s
[17:29:27.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:38:0)
[17:29:27.698] Timer tick, asking Buildbucket for the build status
[17:29:27.841] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:27.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:39:0) after 1m0s
[17:30:27.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:39:0)
[17:30:27.837] Timer tick, asking Buildbucket for the build status
[17:30:28.215] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:28.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:40:0) after 1m0s
[17:31:28.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:40:0)
[17:31:28.265] Timer tick, asking Buildbucket for the build status
[17:31:28.457] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:28.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:41:0) after 1m0s
[17:32:28.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:41:0)
[17:32:28.622] Timer tick, asking Buildbucket for the build status
[17:32:28.803] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:28.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:42:0) after 1m0s
[17:33:28.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:42:0)
[17:33:28.859] Timer tick, asking Buildbucket for the build status
[17:33:29.022] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:29.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:43:0) after 1m0s
[17:34:29.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:43:0)
[17:34:29.059] Timer tick, asking Buildbucket for the build status
[17:34:29.348] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:29.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:44:0) after 1m0s
[17:35:29.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:44:0)
[17:35:29.562] Timer tick, asking Buildbucket for the build status
[17:35:30.348] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:30.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:45:0) after 1m0s
[17:36:30.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:45:0)
[17:36:30.605] Timer tick, asking Buildbucket for the build status
[17:36:31.234] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:31.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:46:0) after 1m0s
[17:37:31.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:46:0)
[17:37:31.392] Timer tick, asking Buildbucket for the build status
[17:37:32.244] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:32.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:47:0) after 1m0s
[17:38:32.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:47:0)
[17:38:32.248] Timer tick, asking Buildbucket for the build status
[17:38:32.906] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:32.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:48:0) after 1m0s
[17:39:33.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:48:0)
[17:39:33.072] Timer tick, asking Buildbucket for the build status
[17:39:33.352] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:33.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:49:0) after 1m0s
[17:40:33.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:49:0)
[17:40:33.468] Timer tick, asking Buildbucket for the build status
[17:40:33.743] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:33.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:50:0) after 1m0s
[17:41:33.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:50:0)
[17:41:33.817] Timer tick, asking Buildbucket for the build status
[17:41:34.010] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:34.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:51:0) after 1m0s
[17:42:34.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:51:0)
[17:42:34.292] Timer tick, asking Buildbucket for the build status
[17:42:34.700] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:34.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:52:0) after 1m0s
[17:43:34.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:52:0)
[17:43:34.797] Timer tick, asking Buildbucket for the build status
[17:43:35.228] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:35.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:53:0) after 1m0s
[17:44:35.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:53:0)
[17:44:35.559] Timer tick, asking Buildbucket for the build status
[17:44:35.822] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:35.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:54:0) after 1m0s
[17:45:36.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:54:0)
[17:45:36.048] Timer tick, asking Buildbucket for the build status
[17:45:36.832] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:36.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:55:0) after 1m0s
[17:46:37.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:55:0)
[17:46:37.488] Timer tick, asking Buildbucket for the build status
[17:46:37.711] Build 8855665807093183328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:37.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021095869228464864:56:0) after 1m0s
[17:46:53.758] Received PubSub notification, asking Buildbucket for the build status
[17:46:54.013] Build 8855665807093183328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:46:54.013] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612979212569421",
"created_by": "project:chromium",
"created_ts": "1612975987306814",
"id": "8855665807093183328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c419a57d6f1ca3fc5cbec7850bbe707016412a48\"}}",
"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\": \"c419a57d6f1ca3fc5cbec7850bbe707016412a48\", \"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-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180462, \"got_angle_revision\": \"0f74ae58ed185108ec38a4cb038ef3c31acd9ff4\", \"got_dawn_revision\": \"02fd17c75403a399672c65aa98e577c7c2ae9010\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"c419a57d6f1ca3fc5cbec7850bbe707016412a48\", \"got_revision_cp\": \"refs/heads/master@{#852675}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"ddadcacd13fae633df256fb967e61d4dbf1c8083\", \"got_v8_revision_cp\": \"refs/heads/9.0.157@{#1}\", \"got_webrtc_revision\": \"ad8a00d25c91ba28ae987d994c362cb183b6e7ed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33212}\", \"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\": \"c419a57d6f1ca3fc5cbec7850bbe707016412a48\", \"swarm_hashes_refs/heads/master(at){#852675}_without_patch\": {\"absl_hardening_tests\": \"286878eb14a9faa2fefe47b6883f4c597f1253f2\", \"accessibility_unittests\": \"d316320ac60d63e36b130197889d0ddb5c117487\", \"angle_unittests\": \"6a1b3fe1d5658f417e1a39d6e1270c04846cdf76\", \"app_shell_unittests\": \"b6b28d0acfbda0647d3440d7851ce004866daab0\", \"aura_unittests\": \"4bb613bb11f1b51063c41281c5a9734930695be5\", \"base_unittests\": \"81762203da67614852163894cc2f4935e74167f4\", \"base_util_unittests\": \"c76701fcf05ffd369cd2e1de7f73904cd0742514\", \"blink_common_unittests\": \"f2620a78bc9c8b1cd77e16419da554d5529ea376\", \"blink_fuzzer_unittests\": \"73c10615528741c59514a437a77207eef61ef20d\", \"blink_heap_unittests\": \"436db72cd04648077684ecc18510d60c347f8a83\", \"blink_platform_unittests\": \"141cc4f8ce09dbc518452ddbc9399b63415b2ef8\", \"blink_python_tests\": \"d8368b8cbc9f36cf7e2cb1cdfa854a93886aeb31\", \"blink_unittests\": \"25f399314041d165b2f6ff495e04678443086ea7\", \"blink_web_tests\": \"27beb91c219603cee8dbbe1fbd622657995ad58c\", \"boringssl_crypto_tests\": \"e9572bf2027d2a556b2a9152b31e2757680769d0\", \"boringssl_ssl_tests\": \"a4da7ecc7326609f212e7ba7240c17c86850c399\", \"browser_tests\": \"0ddb05d554bc07e468dee03b2eb72db134734676\", \"capture_unittests\": \"3a8577bbb9bdb4a4f8e0d2eab92e2bd9e7a157cd\", \"cast_unittests\": \"a40b137fa9b14b753b97b2a4fe78e9d82c910a2b\", \"cc_unittests\": \"f150f0fed9950df5df7f3f145abebaf0c797fc05\", \"chrome_app_unittests\": \"655fe92fd8ed840f24d35e977c6c379bc8608e93\", \"chromedriver_unittests\": \"600834698afdf0da790a335f7d9040e1acb94f0d\", \"components_browsertests\": \"8bfbf87b57761142394ee748e6e099b8ec245c20\", \"components_unittests\": \"a64ae434e5cc3bb4e83f437ed9ded8f728a3e576\", \"compositor_unittests\": \"5459148d3ad58efa4a87bf9bb54514fac57a4a4c\", \"content_browsertests\": \"9c54b9ee5a96c9fb490dffb0c5bf15dfa7dff621\", \"content_shell_crash_test\": \"5fb472010d333aac33ba1f22ac21b192b48a5ff5\", \"content_unittests\": \"5cbee2605c0704b4743b360fc10f6a82f73559a6\", \"crashpad_tests\": \"278ccd161c64144540c4843ea01e5daebb9d5506\", \"cronet_tests\": \"d64ae27ccfd19583cbfdad7340b4ba3b08905d35\", \"cronet_unittests\": \"6c993347bac633bb271170e854fb4da69ea6c348\", \"crypto_unittests\": \"e1e67fee222f6d73e963500815987a5942f930cb\", \"dbus_unittests\": \"81061ebbccf3cd6838ff052e7594567733b25863\", \"device_unittests\": \"3a77ad7a947cb41a7a0e4435dc6335e2ee2dd801\", \"display_unittests\": \"e806fde8ed2f706b07d97aec73333c458bf478d8\", \"events_unittests\": \"86d1a72d7feaa540c890741b31dced7a68dcd972\", \"extensions_browsertests\": \"c520a87e73a39adca07e38cbf69eecf9f249b6c8\", \"extensions_unittests\": \"529b3706ee62f48e4f81a293d395b76fff8aec0b\", \"filesystem_service_unittests\": \"b6374b582d34f69484ca1dc3e66ffcfdaab7c291\", \"flatbuffers_unittests\": \"58976a0c9ae5674987a52610b5f40e2c6cc5fd08\", \"gcm_unit_tests\": \"62d2cf33ac9a52d9f098121b76bcfdd104f837de\", \"gfx_unittests\": \"3e00baf5b47d4003c39f5428869d50abe61b8f40\", \"gin_unittests\": \"6c4e395c28603a071d4b788b88d73e9f5e57fd35\", \"google_apis_unittests\": \"3cb14165803769a60ceabef6c6b57b81c5f3d857\", \"gpu_unittests\": \"a1f4377d8d7d3ee90c51aa232782e61edb2a1ead\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"93c29183848c97e82ba65eef1e3c938372140522\", \"headless_browsertests\": \"84d4d47c77d1a16aa4e4b29cd2e5526d997986f7\", \"headless_unittests\": \"1a77be4fea79619fb67e41530b6bf39b4a2b520d\", \"interactive_ui_tests\": \"b941b44a32cc04ce38719b92c8cd0d907d2ccfc3\", \"ipc_tests\": \"8c3eed9ef3017a97aa76ef76ba70d18923f9f149\", \"jingle_unittests\": \"6af35a1a35601a52eabedcad8a47385ba401abca\", \"latency_unittests\": \"cb406ca951a88228ee1efc55edbeea013ba0a6d3\", \"libjingle_xmpp_unittests\": \"b5e1f3d57822f2caae0f071098220d63833aa815\", \"liburlpattern_unittests\": \"3ea45242667931b305b3e084e22fac65af166365\", \"media_blink_unittests\": \"1b2e094c9daaf9e4b9b84fc42f232ccb4243020a\", \"media_unittests\": \"2fd0f57cabce931a014b044448ca508c7723e674\", \"message_center_unittests\": \"b5d252279dc58dd4c381257a391334efed8403ad\", \"metrics_python_tests\": \"4bc5e7391d0ffcb2e7bb57a84412bcdbd66ec77c\", \"midi_unittests\": \"192c1e2bcff9d237945b46a1237d8d81c3ad9bf6\", \"mojo_core_unittests\": \"3742dd2521cf3678d25d560c2fff6e7e2baf94ba\", \"mojo_unittests\": \"e875bfd2fe025bf99e7d48889296d7ddbbfe17a5\", \"nacl_helper_nonsfi_unittests\": \"9c55ad0aaf9eabb858d8477a22d54aae293faaa7\", \"nacl_loader_unittests\": \"1fdf8344601197362393c34c35421557275fe243\", \"native_theme_unittests\": \"b92e4cdd2abc1d6e911bb3b51c4b0e5ad46655ea\", \"net_unittests\": \"c226970f261efb869ce8f167447121cba3c132d8\", \"openscreen_unittests\": \"8fcbf02ac08004e3dd222e913ecdfc56f6e54dea\", \"pdf_unittests\": \"cc4c7e061e3857a70623e92d28d8ff35d1eb3f3b\", \"perfetto_unittests\": \"032c8a2e41ecb4ea96d104bdb2ea961289084bad\", \"ppapi_unittests\": \"a10dfdcc22faa3550dd77a37320fb40fcbdeffb1\", \"printing_unittests\": \"d8b650bce8cdafb12616772d0697e70472305249\", \"remoting_unittests\": \"56bc33433d88c1d3b4e073ca261dc9a9263b4ced\", \"sandbox_linux_unittests\": \"0e81d0626baf5b1e30a108ff5ec0c40c5f31275f\", \"service_manager_unittests\": \"e327f1cf526c0845378e02fffcdc19ec50094e94\", \"services_unittests\": \"4b1864217c877e365f2801f9ff2ee54657a83aed\", \"shell_dialogs_unittests\": \"b3f847f1c7fa9c4f7ab0b07afc63bdb42fad9e89\", \"skia_unittests\": \"b493537a7fa7f9638e8bd747dcc2dd1eb6fc3ed1\", \"snapshot_unittests\": \"1c957c16de668922bc7cfc50f409b1c49771c5f6\", \"sql_unittests\": \"8583fd6158a63dd10207b20015102301145620f4\", \"storage_unittests\": \"98330d246e3b791c7f35e310640532c634720e99\", \"sync_integration_tests\": \"3c754d420ebe9b744af7c546d648243aa5e53692\", \"telemetry_gpu_unittests\": \"546185a70a2492c09be3ecc7242bd85a0c680aaa\", \"telemetry_perf_unittests\": \"ff2985c958276afcfb00cfd81eff6d613141fea6\", \"telemetry_unittests\": \"8514af78d19e4b27b1cf14272e1e528c96e6047b\", \"traffic_annotation_auditor_unittests\": \"4ef75cdd783cba079c9fcfd20c44cc78b21256ad\", \"ui_base_unittests\": \"d8e4eaa1f38f7b08a63a988e3145db1839f688fd\", \"ui_touch_selection_unittests\": \"d2aed80f66b7c082cb31cdfdc081a7bb293d9f91\", \"unit_tests\": \"c8614db044f4425589e0549c3b900c6a3a8a72c1\", \"url_unittests\": \"10ff8962472c9f58fd1fddc3dbf27a117df56705\", \"views_perftests\": \"f0974c90c25d747da45d3b28928cc75faf860377\", \"views_unittests\": \"c20022aeae531262e485ea085b161e15900a9fdd\", \"viz_unittests\": \"8e88ad93e067dd389dd2671efc13c73a7e57164c\", \"vr_common_unittests\": \"aec1e312f6b76b46206d69bb36584b84bfe77ec1\", \"vr_pixeltests\": \"0278b65591702e7d495adfb4020e19ec9757176c\", \"webdriver_wpt_tests\": \"0fea8e90ef1bdf0b54ddcf0e1151c0e24953f2ad\", \"weblayer_browsertests\": \"71a2a1dec35cb995f470222ce1790c9d2bd2398c\", \"weblayer_unittests\": \"b6d5ca435c8e0abd8c2cd41e0d0d3696b1f2d825\", \"wm_unittests\": \"01722e502719ca72eef6f144025785844b6c57a9\", \"wtf_unittests\": \"4f26e79c32b89edf092f79891ec9a8ab160aa30d\", \"x11_unittests\": \"c065cfaa67a5d8e7bdf350493900961b371a8de0\", \"xr_browser_tests\": \"6dcc9fce8a001b9c459547de372a0e50a7513325\", \"zlib_unittests\": \"f0e75be84e0158f155c9fec1f9448210a5d53d8a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_171aeb6ea7c277f8a23548bef504d6412b8f4fe5eb401735c265dcbe781a3afe_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_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-east1-d-8-68-2v8w\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612975989727913",
"status": "COMPLETED",
"status_changed_ts": "1612979213064132",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180462",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c419a57d6f1ca3fc5cbec7850bbe707016412a48",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021095869228464864",
"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/8855665807093183328/+/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:51a5ade7ee0adb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612979213130525",
"url": "https://ci.chromium.org/b/8855665807093183328",
"utcnow_ts": "1612979213997375"
}
}
[17:46:54.013] Invocation finished in 53m48.127351649s with status SUCCEEDED