[22:07:12.453] New invocation is queued and will start shortly
[22:07:13.659] Starting the invocation (attempt 1)
[22:07:13.749] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:07:13.749] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:07:13.749] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019988943603476496",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c08da16e9d480b40a9d617972af0c49d4aca9c34\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019988943603476496",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"gitiles_ref:refs/heads/master"
]
}
[22:07:15.516] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614031633993860",
"id": "8854558881312241248",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c08da16e9d480b40a9d617972af0c49d4aca9c34\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614031635203376",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180828",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019988943603476496",
"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/8854558881312241248/+/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": "1614031635204035",
"url": "https://ci.chromium.org/b/8854558881312241248",
"utcnow_ts": "1614031635443875"
}
}
[22:07:15.516] Task URL: https://ci.chromium.org/b/8854558881312241248
[22:07:15.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:2:0) after 1m0s
[22:07:19.446] Received PubSub notification, asking Buildbucket for the build status
[22:07:19.543] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:15.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:2:0)
[22:08:15.513] Timer tick, asking Buildbucket for the build status
[22:08:15.796] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:15.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:4:0) after 1m0s
[22:09:15.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:4:0)
[22:09:15.834] Timer tick, asking Buildbucket for the build status
[22:09:15.901] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:15.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:5:0) after 1m0s
[22:10:15.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:5:0)
[22:10:15.916] Timer tick, asking Buildbucket for the build status
[22:10:16.146] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:16.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:6:0) after 1m0s
[22:11:16.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:6:0)
[22:11:16.158] Timer tick, asking Buildbucket for the build status
[22:11:16.451] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:16.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:7:0) after 1m0s
[22:12:16.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:7:0)
[22:12:16.520] Timer tick, asking Buildbucket for the build status
[22:12:16.608] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:8:0) after 1m0s
[22:13:16.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:8:0)
[22:13:16.705] Timer tick, asking Buildbucket for the build status
[22:13:16.897] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:16.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:9:0) after 1m0s
[22:14:17.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:9:0)
[22:14:17.006] Timer tick, asking Buildbucket for the build status
[22:14:17.132] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:10:0) after 1m0s
[22:15:17.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:10:0)
[22:15:17.256] Timer tick, asking Buildbucket for the build status
[22:15:17.704] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:17.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:11:0) after 1m0s
[22:16:17.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:11:0)
[22:16:17.795] Timer tick, asking Buildbucket for the build status
[22:16:17.868] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:17.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:12:0) after 1m0s
[22:17:18.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:12:0)
[22:17:18.055] Timer tick, asking Buildbucket for the build status
[22:17:18.176] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:18.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:13:0) after 1m0s
[22:18:18.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:13:0)
[22:18:18.335] Timer tick, asking Buildbucket for the build status
[22:18:18.624] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:18.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:14:0) after 1m0s
[22:19:18.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:14:0)
[22:19:18.653] Timer tick, asking Buildbucket for the build status
[22:19:19.046] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:15:0) after 1m0s
[22:20:19.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:15:0)
[22:20:19.077] Timer tick, asking Buildbucket for the build status
[22:20:19.148] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:19.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:16:0) after 1m0s
[22:21:19.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:16:0)
[22:21:19.242] Timer tick, asking Buildbucket for the build status
[22:21:19.609] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:19.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:17:0) after 1m0s
[22:22:19.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:17:0)
[22:22:19.645] Timer tick, asking Buildbucket for the build status
[22:22:19.845] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:19.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:18:0) after 1m0s
[22:23:19.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:18:0)
[22:23:19.945] Timer tick, asking Buildbucket for the build status
[22:23:20.049] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:20.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:19:0) after 1m0s
[22:24:20.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:19:0)
[22:24:20.167] Timer tick, asking Buildbucket for the build status
[22:24:20.275] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:20.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:20:0) after 1m0s
[22:25:20.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:20:0)
[22:25:20.340] Timer tick, asking Buildbucket for the build status
[22:25:20.628] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:20.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:21:0) after 1m0s
[22:26:20.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:21:0)
[22:26:20.804] Timer tick, asking Buildbucket for the build status
[22:26:20.876] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:22:0) after 1m0s
[22:27:21.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:22:0)
[22:27:21.011] Timer tick, asking Buildbucket for the build status
[22:27:21.180] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:21.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:23:0) after 1m0s
[22:28:21.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:23:0)
[22:28:21.199] Timer tick, asking Buildbucket for the build status
[22:28:21.476] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:21.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:24:0) after 1m0s
[22:29:21.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:24:0)
[22:29:21.655] Timer tick, asking Buildbucket for the build status
[22:29:21.829] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:21.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:25:0) after 1m0s
[22:30:21.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:25:0)
[22:30:21.875] Timer tick, asking Buildbucket for the build status
[22:30:21.963] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:21.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:26:0) after 1m0s
[22:31:22.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:26:0)
[22:31:22.015] Timer tick, asking Buildbucket for the build status
[22:31:22.095] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:22.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:27:0) after 1m0s
[22:32:22.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:27:0)
[22:32:22.198] Timer tick, asking Buildbucket for the build status
[22:32:22.299] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:22.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:28:0) after 1m0s
[22:33:22.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:28:0)
[22:33:22.362] Timer tick, asking Buildbucket for the build status
[22:33:22.554] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:22.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:29:0) after 1m0s
[22:34:22.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:29:0)
[22:34:22.557] Timer tick, asking Buildbucket for the build status
[22:34:22.650] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:22.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:30:0) after 1m0s
[22:35:22.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:30:0)
[22:35:22.747] Timer tick, asking Buildbucket for the build status
[22:35:22.983] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:22.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:31:0) after 1m0s
[22:36:23.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:31:0)
[22:36:23.085] Timer tick, asking Buildbucket for the build status
[22:36:23.162] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:23.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:32:0) after 1m0s
[22:37:23.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:32:0)
[22:37:23.208] Timer tick, asking Buildbucket for the build status
[22:37:23.395] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:23.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:33:0) after 1m0s
[22:38:23.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:33:0)
[22:38:23.414] Timer tick, asking Buildbucket for the build status
[22:38:23.981] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:23.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:34:0) after 1m0s
[22:39:24.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:34:0)
[22:39:24.009] Timer tick, asking Buildbucket for the build status
[22:39:24.089] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:24.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:35:0) after 1m0s
[22:40:24.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:35:0)
[22:40:24.156] Timer tick, asking Buildbucket for the build status
[22:40:24.241] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:24.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:36:0) after 1m0s
[22:41:24.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:36:0)
[22:41:24.274] Timer tick, asking Buildbucket for the build status
[22:41:24.476] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:24.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:37:0) after 1m0s
[22:42:24.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:37:0)
[22:42:24.565] Timer tick, asking Buildbucket for the build status
[22:42:24.927] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:24.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:38:0) after 1m0s
[22:43:24.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:38:0)
[22:43:24.937] Timer tick, asking Buildbucket for the build status
[22:43:25.033] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:25.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:39:0) after 1m0s
[22:44:25.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:39:0)
[22:44:25.087] Timer tick, asking Buildbucket for the build status
[22:44:25.154] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:40:0) after 1m0s
[22:45:25.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:40:0)
[22:45:25.192] Timer tick, asking Buildbucket for the build status
[22:45:25.270] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:25.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:41:0) after 1m0s
[22:46:25.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:41:0)
[22:46:25.338] Timer tick, asking Buildbucket for the build status
[22:46:25.422] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:25.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:42:0) after 1m0s
[22:47:25.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:42:0)
[22:47:25.501] Timer tick, asking Buildbucket for the build status
[22:47:25.606] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:43:0) after 1m0s
[22:48:25.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:43:0)
[22:48:25.772] Timer tick, asking Buildbucket for the build status
[22:48:25.857] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:25.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:44:0) after 1m0s
[22:49:25.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:44:0)
[22:49:25.931] Timer tick, asking Buildbucket for the build status
[22:49:26.006] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:26.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:45:0) after 1m0s
[22:50:26.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:45:0)
[22:50:26.158] Timer tick, asking Buildbucket for the build status
[22:50:26.244] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:26.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:46:0) after 1m0s
[22:51:26.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:46:0)
[22:51:26.317] Timer tick, asking Buildbucket for the build status
[22:51:26.630] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:26.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:47:0) after 1m0s
[22:52:26.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:47:0)
[22:52:26.750] Timer tick, asking Buildbucket for the build status
[22:52:26.873] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:26.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:48:0) after 1m0s
[22:53:26.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:48:0)
[22:53:26.892] Timer tick, asking Buildbucket for the build status
[22:53:27.008] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:27.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:49:0) after 1m0s
[22:54:27.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:49:0)
[22:54:27.144] Timer tick, asking Buildbucket for the build status
[22:54:27.292] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:27.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:50:0) after 1m0s
[22:55:27.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:50:0)
[22:55:27.336] Timer tick, asking Buildbucket for the build status
[22:55:27.419] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:27.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:51:0) after 1m0s
[22:56:27.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:51:0)
[22:56:27.557] Timer tick, asking Buildbucket for the build status
[22:56:27.737] Build 8854558881312241248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:27.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019988943603476496:52:0) after 1m0s
[22:56:53.384] Received PubSub notification, asking Buildbucket for the build status
[22:56:53.459] Build 8854558881312241248: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:56:53.459] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614034612590895",
"created_by": "project:chromium",
"created_ts": "1614031633993860",
"id": "8854558881312241248",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c08da16e9d480b40a9d617972af0c49d4aca9c34\"}}",
"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\": \"c08da16e9d480b40a9d617972af0c49d4aca9c34\", \"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-192-q0uk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180828, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c08da16e9d480b40a9d617972af0c49d4aca9c34\", \"got_revision_cp\": \"refs/heads/master@{#856469}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3ffbd62bb3437e4b12fdf8ee1dd7a3eb8a5d27ee\", \"got_v8_revision\": \"c8019e4062f5bfc3094573fec601a3682ca791bd\", \"got_v8_revision_cp\": \"refs/heads/9.0.235@{#1}\", \"got_webrtc_revision\": \"28547e96cc2b1be9ebdea7455c46f12fe76d90c7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33318}\", \"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\": \"c08da16e9d480b40a9d617972af0c49d4aca9c34\", \"swarm_hashes_refs/heads/master(at){#856469}_without_patch\": {\"absl_hardening_tests\": \"0731fa2c0fc411782465cd23234a6ba5d759b734\", \"accessibility_unittests\": \"a836e9bfa8e6cd91ac6255d31e1654c90fd1dcf9\", \"angle_unittests\": \"589a94d95606f53f199ec8a33f888a1d1830c79f\", \"app_shell_unittests\": \"81b5f839acb9ecb127248c8585232b894d0463cc\", \"aura_unittests\": \"6c210d0f1f1859d5d8b69d3ddaf6fed98ae71e1e\", \"base_unittests\": \"bcb7acad64e2cca566a6ef378bfb1354aefd393d\", \"base_util_unittests\": \"887c2cb11bfb8328a8a749d90d2653bc3c21e9a4\", \"blink_common_unittests\": \"011485401d1f22cd11dbb5125ad5aefc5315b4fc\", \"blink_fuzzer_unittests\": \"c750564070f6a6440a9a42b7ae565295c74d6e1b\", \"blink_heap_unittests\": \"77c00c65c958bcbebe21315d319432a16709d3af\", \"blink_platform_unittests\": \"b09e9346c71db9049baca179a062d695c6f895ea\", \"blink_python_tests\": \"5c70098189ed7f3a0528188e3aef2f962e00e1dd\", \"blink_unittests\": \"0b7d8976f0f78b2c5d82216f640c9d2e04530268\", \"blink_web_tests\": \"e64af6e3aeaa48112b941d4b9afe3c8962b22c37\", \"boringssl_crypto_tests\": \"131275928ab93d542d9311c344bf46ae149512d1\", \"boringssl_ssl_tests\": \"68fe75264022a0077374368bb21c4878394e8d0b\", \"browser_tests\": \"fdae035e919809e9c1cdde571629ff2bdf29b14b\", \"capture_unittests\": \"001a5e3f334b049fdfe0be395c896d3a3d10bbe4\", \"cast_unittests\": \"29581819f89e51f51cd18c8c0a50c9e5e17ed6b8\", \"cc_unittests\": \"57a96a7041b25ea835bbed174f68a3858828fd3b\", \"chrome_app_unittests\": \"57a7e1dd6a494d0f6582b3b78b1a8f79027b8f55\", \"chromedriver_unittests\": \"c0c1b77b51806620a32b449c22abdc6bb82e84a8\", \"components_browsertests\": \"796daf5864e7b9083893474445bee3c2ad8c29c4\", \"components_unittests\": \"1c1179e7aceb1f5a7ae355c1faa74ca1913052f9\", \"compositor_unittests\": \"5389acc5db41c4ad31f0d016b277e4d27c5833c8\", \"content_browsertests\": \"fb9f8d86680a9ce1a6759f1add22f34edce47481\", \"content_shell_crash_test\": \"1db1a2689ae2aeb1017fe54270ab22b2fa9c3e28\", \"content_unittests\": \"d80966f55d3f76a0b9eabfd2a68c0d697002041e\", \"crashpad_tests\": \"e358fbdeeb48bda8129c9570cc4ebf4c92fe5400\", \"cronet_tests\": \"39872f658c54dca26503134f7af6449d9a631c26\", \"cronet_unittests\": \"ced975bee50084ff417efe6ac731885b796cc3d5\", \"crypto_unittests\": \"54684e0db141dfbede29bdd686f906591b154ea2\", \"dbus_unittests\": \"7324e21402e533a8562feadf713bc92a81549336\", \"device_unittests\": \"ec1f969d4331d2f93315bf1001d327fe73d09a79\", \"display_unittests\": \"9e2c63eacfcd568ed0d0748e8b04895b7d6eac15\", \"events_unittests\": \"6285dcd48f0d83926f82fde8787ee77d1fae0e1c\", \"extensions_browsertests\": \"86880ab71d73e75d3b050da042a65b022e7ed6ec\", \"extensions_unittests\": \"36f760215dc36f6cde027e5c8c62b25959be4f4b\", \"filesystem_service_unittests\": \"c98602f89a6d9cff90f7670bc853a45bffdf62da\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"5ad8590c2c6599da274921ab7f90400b5e082ec4\", \"gfx_unittests\": \"0a9ca6772dacb1876ff9751a0029d40028e21bc5\", \"gin_unittests\": \"213bcba13fd60c0a97fdad80775b800d2cf9a60e\", \"google_apis_unittests\": \"065607b8ac0c4d53f11b0f1f8c6dc17af9f23887\", \"gpu_unittests\": \"d8a5a2c9bbf4707e9d2f025446b887679e88fe8a\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"7047f5bef776f5d8fc965f3b27ad265effa25a19\", \"headless_browsertests\": \"068eb5f19371f0411ed706e235d874c0845a94e2\", \"headless_unittests\": \"58e6a04f525ced613a2b6d2be540dd16aac2c9bd\", \"interactive_ui_tests\": \"5410fe2ddebbbcfcaab4e28ea8810218f3449939\", \"ipc_tests\": \"ef940fa3bde370afab8a1d20f19d180ed6e63315\", \"jingle_unittests\": \"eb41d4d43e1f376c14e6508c49fa4327d5bb7da2\", \"latency_unittests\": \"1b53a18ce8d0e62e777d45b344dc838c8bbb196b\", \"libjingle_xmpp_unittests\": \"ed771d8ab3d1103fa31e763f8594496a1befc535\", \"liburlpattern_unittests\": \"bbb5953b05c8c7933006c5eec04624af2cf8e04b\", \"media_blink_unittests\": \"d6c4da09943057a9f15c53cb95d3b1e0730920dc\", \"media_unittests\": \"03d633cbd5f88c88cd2a7e028ccc6896d4a5f2f6\", \"message_center_unittests\": \"6d55fe9d42db69fdb742f221d132ce71d9dec485\", \"metrics_python_tests\": \"c26e09d29240a874fd5e603e29247041ea31a869\", \"midi_unittests\": \"3c408258c14b2fd2893dd16d4e07cb96eabcb247\", \"mojo_core_unittests\": \"55ba6e5dd39b0f215229b0aea56c8a3212c9dd2b\", \"mojo_unittests\": \"876f5b2fb71976a3e75a8f03cf00414f8918ee7c\", \"nacl_helper_nonsfi_unittests\": \"fce9d684523d022469205b3919ccf7b7d68946d0\", \"nacl_loader_unittests\": \"028f110efe3dfe2f397db73419ea4b8dd78c0a6c\", \"native_theme_unittests\": \"ac17724aa366df897d1df1c1a469ecb9ef1243a3\", \"net_unittests\": \"a171cdb8432ab935f56c694446d2368de13003db\", \"openscreen_unittests\": \"b31db2cf56d709e81a92b905104a47b64ffa5353\", \"pdf_unittests\": \"e0d5eca526d7f7ed426edb4888870cdf2385f640\", \"perfetto_unittests\": \"a85a0ba85a9c6df28b9af79d858eea7cc827b713\", \"ppapi_unittests\": \"3e49106d0c7d96d58a8114f85d6186b5af884831\", \"printing_unittests\": \"9808cec3b2f722e1a4f5c276cbc94af36560b4f7\", \"remoting_unittests\": \"d8c85211fc4073a42018a0c1ed51c69bdb00b3f9\", \"sandbox_linux_unittests\": \"29104ebea69a9a1f60035c5e4d34ea464631e239\", \"service_manager_unittests\": \"a6e62ed58b074d0e40001e041a24ed2b55c311ad\", \"services_unittests\": \"864a31a79c14e29147cacf03000bc9344472b0d8\", \"shell_dialogs_unittests\": \"2d91a9d1a6de4dcbb17fcf5a5bf135871a8e597f\", \"skia_unittests\": \"9eda019be012b8ddf7cb7067ed6517e602447c85\", \"snapshot_unittests\": \"a3b14e9180f991a050ace17ed89fd8f4ddca0dd1\", \"sql_unittests\": \"5fce74cd43d4a1c5380b341466c6be36e51a4c28\", \"storage_unittests\": \"c3b138c8aacdf8f5e8785ac976349171b5ffea05\", \"sync_integration_tests\": \"a6e1c96ccde89615c6155bab39156ec63013e62a\", \"telemetry_gpu_unittests\": \"26c009f97ed5eb943cb6c3e910c2b1daccd66ece\", \"telemetry_perf_unittests\": \"5fb9c90a23dc0f258973f7dc00940f9a967251c8\", \"telemetry_unittests\": \"26f846b0955f54f7fa270d6e67e293eeda6f6d7a\", \"traffic_annotation_auditor_unittests\": \"d4ff194a6a1f75f26506c10feccda0e310c226ad\", \"ui_base_unittests\": \"9ea065596e09abe9b08d91d4fba0d9e877a1ca01\", \"ui_touch_selection_unittests\": \"547022795690eeb003aefad7950584cc1d7f2398\", \"unit_tests\": \"8baf33f1ad99d9d845cecab5a9a72e839e1e0308\", \"url_unittests\": \"a0c349458962d687d1c732bc4d6e438362b3a479\", \"views_perftests\": \"486041b569e7393edbaaba11090b3e30b091f070\", \"views_unittests\": \"4507629627cf11ab861d6d667250ac3617a46283\", \"viz_unittests\": \"10431734e2e15aec6b4529b727087c7c4bce0869\", \"vr_common_unittests\": \"7f512684266b36b45bbe0762fcdc1e075ee2eb58\", \"vr_pixeltests\": \"ef51ed4f716d1302f97872589fd2085ff92157c4\", \"webdriver_wpt_tests\": \"196f76672c002b2ddc226b262ac08eaabc63b29f\", \"weblayer_browsertests\": \"54c8fba81baa02eb2480de787b95c5f011c124b8\", \"weblayer_unittests\": \"c6e6702c8f37709ee6dfe1739556343fee51f982\", \"wm_unittests\": \"e47e580ea758b79085e4c623a664f6d49345b073\", \"wtf_unittests\": \"3089032d18bb2b12ed456429367d9aaa4440251d\", \"x11_unittests\": \"a34f0b0d678515bd75693ee2114b315f098b159f\", \"xr_browser_tests\": \"b90a18d138b0ef053ff5c7eb76c8f92d1dda24a0\", \"zlib_unittests\": \"43ff2d9f0c29c49d26f793336aecfc23a52292f6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_27494552be378ad44330ee8c940cd18606508d3a430497a5c08d1541438da4f7_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_b14893b55edaf5e4dad6913e524bd3694194da568bc8f7a76820eff0afe1bec5_v2\", \"builder_dd9616d41d89d2602800dfeda62c5b43a746c971e6e18e9b0c84ab0482a0e409_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-192-q0uk\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614031637837183",
"status": "COMPLETED",
"status_changed_ts": "1614034612868487",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180828",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c08da16e9d480b40a9d617972af0c49d4aca9c34",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019988943603476496",
"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/8854558881312241248/+/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:51e499ce3364df10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614034612880761",
"url": "https://ci.chromium.org/b/8854558881312241248",
"utcnow_ts": "1614034613451536"
}
}
[22:56:53.459] Invocation finished in 49m41.0341118s with status SUCCEEDED