[11:08:26.350] New invocation is queued and will start shortly
[11:08:27.463] Starting the invocation (attempt 1)
[11:08:27.506] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:08:27.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:08:27.506] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019758598812991952",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019758598812991952",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"gitiles_ref:refs/heads/master"
]
}
[11:08:28.192] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614251307580851",
"id": "8854328536861766272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614251308001837",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180921",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019758598812991952",
"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/8854328536861766272/+/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": "1614251308001955",
"url": "https://ci.chromium.org/b/8854328536861766272",
"utcnow_ts": "1614251308183483"
}
}
[11:08:28.192] Task URL: https://ci.chromium.org/b/8854328536861766272
[11:08:28.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:2:0) after 1m0s
[11:08:40.032] Received PubSub notification, asking Buildbucket for the build status
[11:08:40.256] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:28.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:2:0)
[11:09:28.213] Timer tick, asking Buildbucket for the build status
[11:09:28.387] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:28.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:4:0) after 1m0s
[11:10:28.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:4:0)
[11:10:28.404] Timer tick, asking Buildbucket for the build status
[11:10:28.720] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:28.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:5:0) after 1m0s
[11:11:28.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:5:0)
[11:11:28.721] Timer tick, asking Buildbucket for the build status
[11:11:28.826] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:28.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:6:0) after 1m0s
[11:12:28.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:6:0)
[11:12:28.829] Timer tick, asking Buildbucket for the build status
[11:12:29.111] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:29.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:7:0) after 1m0s
[11:13:29.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:7:0)
[11:13:29.207] Timer tick, asking Buildbucket for the build status
[11:13:29.296] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:29.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:8:0) after 1m0s
[11:14:29.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:8:0)
[11:14:29.278] Timer tick, asking Buildbucket for the build status
[11:14:29.359] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:29.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:9:0) after 1m0s
[11:15:29.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:9:0)
[11:15:29.374] Timer tick, asking Buildbucket for the build status
[11:15:29.643] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:29.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:10:0) after 1m0s
[11:16:29.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:10:0)
[11:16:29.658] Timer tick, asking Buildbucket for the build status
[11:16:29.792] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:29.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:11:0) after 1m0s
[11:17:29.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:11:0)
[11:17:29.828] Timer tick, asking Buildbucket for the build status
[11:17:29.916] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:29.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:12:0) after 1m0s
[11:18:29.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:12:0)
[11:18:29.976] Timer tick, asking Buildbucket for the build status
[11:18:30.106] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:30.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:13:0) after 1m0s
[11:19:30.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:13:0)
[11:19:30.148] Timer tick, asking Buildbucket for the build status
[11:19:30.314] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:30.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:14:0) after 1m0s
[11:20:30.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:14:0)
[11:20:30.361] Timer tick, asking Buildbucket for the build status
[11:20:30.526] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:30.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:15:0) after 1m0s
[11:21:30.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:15:0)
[11:21:30.542] Timer tick, asking Buildbucket for the build status
[11:21:30.625] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:30.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:16:0) after 1m0s
[11:22:30.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:16:0)
[11:22:30.631] Timer tick, asking Buildbucket for the build status
[11:22:30.785] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:30.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:17:0) after 1m0s
[11:23:30.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:17:0)
[11:23:30.810] Timer tick, asking Buildbucket for the build status
[11:23:30.885] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:30.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:18:0) after 1m0s
[11:24:30.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:18:0)
[11:24:30.903] Timer tick, asking Buildbucket for the build status
[11:24:30.987] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:19:0) after 1m0s
[11:25:31.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:19:0)
[11:25:31.002] Timer tick, asking Buildbucket for the build status
[11:25:31.210] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:31.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:20:0) after 1m0s
[11:26:31.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:20:0)
[11:26:31.241] Timer tick, asking Buildbucket for the build status
[11:26:31.301] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:31.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:21:0) after 1m0s
[11:27:31.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:21:0)
[11:27:31.318] Timer tick, asking Buildbucket for the build status
[11:27:31.525] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:31.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:22:0) after 1m0s
[11:28:31.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:22:0)
[11:28:31.542] Timer tick, asking Buildbucket for the build status
[11:28:31.940] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:31.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:23:0) after 1m0s
[11:29:31.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:23:0)
[11:29:31.991] Timer tick, asking Buildbucket for the build status
[11:29:32.072] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:32.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:24:0) after 1m0s
[11:30:32.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:24:0)
[11:30:32.125] Timer tick, asking Buildbucket for the build status
[11:30:32.381] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:32.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:25:0) after 1m0s
[11:31:32.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:25:0)
[11:31:32.502] Timer tick, asking Buildbucket for the build status
[11:31:32.607] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:32.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:26:0) after 1m0s
[11:32:32.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:26:0)
[11:32:32.648] Timer tick, asking Buildbucket for the build status
[11:32:32.745] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:32.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:27:0) after 1m0s
[11:33:32.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:27:0)
[11:33:32.834] Timer tick, asking Buildbucket for the build status
[11:33:32.997] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:32.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:28:0) after 1m0s
[11:34:33.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:28:0)
[11:34:33.037] Timer tick, asking Buildbucket for the build status
[11:34:33.248] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:33.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:29:0) after 1m0s
[11:35:33.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:29:0)
[11:35:33.304] Timer tick, asking Buildbucket for the build status
[11:35:33.457] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:33.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:30:0) after 1m0s
[11:36:33.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:30:0)
[11:36:33.459] Timer tick, asking Buildbucket for the build status
[11:36:33.733] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:33.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:31:0) after 1m0s
[11:37:33.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:31:0)
[11:37:33.755] Timer tick, asking Buildbucket for the build status
[11:37:33.864] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:33.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:32:0) after 1m0s
[11:38:33.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:32:0)
[11:38:33.881] Timer tick, asking Buildbucket for the build status
[11:38:33.955] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:33.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:33:0) after 1m0s
[11:39:33.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:33:0)
[11:39:33.985] Timer tick, asking Buildbucket for the build status
[11:39:34.324] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:34.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:34:0) after 1m0s
[11:40:34.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:34:0)
[11:40:34.396] Timer tick, asking Buildbucket for the build status
[11:40:34.499] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:34.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:35:0) after 1m0s
[11:41:34.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:35:0)
[11:41:34.551] Timer tick, asking Buildbucket for the build status
[11:41:34.639] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:34.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:36:0) after 1m0s
[11:42:34.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:36:0)
[11:42:34.890] Timer tick, asking Buildbucket for the build status
[11:42:35.050] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:35.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:37:0) after 1m0s
[11:43:35.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:37:0)
[11:43:35.105] Timer tick, asking Buildbucket for the build status
[11:43:35.541] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:38:0) after 1m0s
[11:44:35.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:38:0)
[11:44:35.531] Timer tick, asking Buildbucket for the build status
[11:44:35.612] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:35.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:39:0) after 1m0s
[11:45:35.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:39:0)
[11:45:35.617] Timer tick, asking Buildbucket for the build status
[11:45:35.755] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:35.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:40:0) after 1m0s
[11:46:35.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:40:0)
[11:46:35.730] Timer tick, asking Buildbucket for the build status
[11:46:36.050] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:36.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:41:0) after 1m0s
[11:47:36.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:41:0)
[11:47:36.071] Timer tick, asking Buildbucket for the build status
[11:47:36.154] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:36.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:42:0) after 1m0s
[11:48:36.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:42:0)
[11:48:36.171] Timer tick, asking Buildbucket for the build status
[11:48:36.242] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:36.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:43:0) after 1m0s
[11:49:36.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:43:0)
[11:49:36.268] Timer tick, asking Buildbucket for the build status
[11:49:36.347] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:36.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:44:0) after 1m0s
[11:50:36.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:44:0)
[11:50:36.350] Timer tick, asking Buildbucket for the build status
[11:50:36.594] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:36.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:45:0) after 1m0s
[11:51:36.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:45:0)
[11:51:36.667] Timer tick, asking Buildbucket for the build status
[11:51:36.746] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:36.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:46:0) after 1m0s
[11:52:36.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:46:0)
[11:52:36.763] Timer tick, asking Buildbucket for the build status
[11:52:36.835] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:36.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:47:0) after 1m0s
[11:53:36.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:47:0)
[11:53:36.912] Timer tick, asking Buildbucket for the build status
[11:53:36.987] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:48:0) after 1m0s
[11:54:37.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:48:0)
[11:54:37.028] Timer tick, asking Buildbucket for the build status
[11:54:37.126] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:37.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:49:0) after 1m0s
[11:55:37.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:49:0)
[11:55:37.701] Timer tick, asking Buildbucket for the build status
[11:55:37.778] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:50:0) after 1m0s
[11:56:37.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:50:0)
[11:56:37.978] Timer tick, asking Buildbucket for the build status
[11:56:38.144] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:38.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:51:0) after 1m0s
[11:57:38.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:51:0)
[11:57:38.191] Timer tick, asking Buildbucket for the build status
[11:57:38.256] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:38.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:52:0) after 1m0s
[11:58:38.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:52:0)
[11:58:38.420] Timer tick, asking Buildbucket for the build status
[11:58:38.487] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:53:0) after 1m0s
[11:59:38.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:53:0)
[11:59:38.810] Timer tick, asking Buildbucket for the build status
[11:59:38.871] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:38.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:54:0) after 1m0s
[12:00:38.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:54:0)
[12:00:38.923] Timer tick, asking Buildbucket for the build status
[12:00:39.001] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:39.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:55:0) after 1m0s
[12:01:39.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:55:0)
[12:01:39.167] Timer tick, asking Buildbucket for the build status
[12:01:39.305] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:39.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:56:0) after 1m0s
[12:02:39.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:56:0)
[12:02:39.377] Timer tick, asking Buildbucket for the build status
[12:02:39.451] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:39.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:57:0) after 1m0s
[12:03:39.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:57:0)
[12:03:39.442] Timer tick, asking Buildbucket for the build status
[12:03:39.511] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:39.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:58:0) after 1m0s
[12:04:43.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:58:0)
[12:04:43.160] Timer tick, asking Buildbucket for the build status
[12:04:43.271] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:43.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:59:0) after 1m0s
[12:05:43.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:59:0)
[12:05:43.307] Timer tick, asking Buildbucket for the build status
[12:05:43.402] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:43.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:60:0) after 1m0s
[12:06:43.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:60:0)
[12:06:43.424] Timer tick, asking Buildbucket for the build status
[12:06:43.555] Build 8854328536861766272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:43.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019758598812991952:61:0) after 1m0s
[12:07:15.535] Received PubSub notification, asking Buildbucket for the build status
[12:07:15.776] Build 8854328536861766272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:07:15.776] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614254834203469",
"created_by": "project:chromium",
"created_ts": "1614251307580851",
"id": "8854328536861766272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\"}}",
"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\": \"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\", \"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-151-uukz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180921, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"5eb496b863da5b40dc5c9a713c8ca1e413811f35\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\", \"got_revision_cp\": \"refs/heads/master@{#857616}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"cd0373f013b5c9672c05e79a48bb1e9fb5f50fa4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33333}\", \"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\": \"dd4075b2d27aad795d41de1b3f10d9c3f70fdb77\", \"swarm_hashes_refs/heads/master(at){#857616}_without_patch\": {\"absl_hardening_tests\": \"d41de37e0e46aa49b88a0475caa974e16e920687\", \"accessibility_unittests\": \"71988e8f6a4b27d7ff82d3754a18aef8ede68b53\", \"angle_unittests\": \"78056feec24b34aff5763f36ad6c9300cd0797d5\", \"app_shell_unittests\": \"e324997b814e2455f2230b3632abbe4af073c927\", \"aura_unittests\": \"f43f86f533b31c88289e93cfd83ef706a7854861\", \"base_unittests\": \"46ef81e102afa822e6c6e4840f237fd506055b18\", \"base_util_unittests\": \"2ef1e9d6097216f0c187850a34dd1ea39e9ad58b\", \"blink_common_unittests\": \"c979d8abfcc348e35f1e8bf4bcb52cab70450feb\", \"blink_fuzzer_unittests\": \"6a1b7ff9c85a63015f194f99a5d00864033888cb\", \"blink_heap_unittests\": \"ade8058fde9e568c6f9b776239879b1f0c172aef\", \"blink_platform_unittests\": \"728d6884bbccc8099b3a17daea6d43ae6ab3ecd2\", \"blink_python_tests\": \"4466b68fabbc13dd5dbf3207a2103c43ae32b9e5\", \"blink_unittests\": \"bf217b22bc3fca3236f6c9f543115d23462cebcd\", \"blink_web_tests\": \"8cee587a739bdb80acf87f991699127ba4b28bc0\", \"boringssl_crypto_tests\": \"505906446a795f738a95ba6b59770bcb63482890\", \"boringssl_ssl_tests\": \"cdfbc586db3a539c2061918e99a4a8e4f8d0e493\", \"browser_tests\": \"59890a39273321675551d8b704937b1264874c07\", \"capture_unittests\": \"09e43f1b4fc364a1f0e0a0f9dcad6d291df58558\", \"cast_unittests\": \"04ca25dbfad5cdeab33fdfd072c02f4c9b47cca5\", \"cc_unittests\": \"541ee766b962d390b74f6c31f998f211b1220792\", \"chrome_app_unittests\": \"3f647236f331d3d1ea91ea0b9548ae57d0064ae1\", \"chromedriver_unittests\": \"784871a5d4e6ae02db0d8472f33f39133c45109f\", \"color_unittests\": \"ad5ff9d5a5fd6fb7d13a7b9e78cccbc0b28e8cdd\", \"components_browsertests\": \"405228f8f076bb7bd5f234a23e56c434bd6d427a\", \"components_unittests\": \"fee9958b0f31312f82afbfd4739a6467a07ce5d3\", \"compositor_unittests\": \"fd7133a2b759f12f31c39f20f27ba42860150521\", \"content_browsertests\": \"bf465521523fb0cd79d4123b536f16d8d15f9f37\", \"content_shell_crash_test\": \"d0ba34d566ed65fb72aa90bb737c7fd41d4104a5\", \"content_unittests\": \"be7c6046a3c78faf92733a4fc4d884aad39b6e6f\", \"crashpad_tests\": \"d6013cd0ca6b0e410e9c3e6340679d2effa1fef0\", \"cronet_tests\": \"812b543b6b7642726de325c6d313e0cecafe3d92\", \"cronet_unittests\": \"e9c24e4c271cd024df86d52f5d998703cf0a18f2\", \"crypto_unittests\": \"c33b02f980d233c363cc5ce4e686dca774df713c\", \"dbus_unittests\": \"7dc4b97dbeeb47c3798d9faf5181d27dc1f2ec41\", \"device_unittests\": \"08b60ffc374906d61cebfe76c43e447c4f046060\", \"display_unittests\": \"cd8d1d2a15d42315fcd09c8d9c3e287b812ccabd\", \"events_unittests\": \"62ea1cc281dc58c565b2f4d22335907f2920990d\", \"extensions_browsertests\": \"a3d42d7fb56f0a59a629b760528be901f8abd913\", \"extensions_unittests\": \"bf578afc617ab705df26eba04c448ee4331cf3bc\", \"filesystem_service_unittests\": \"b6175a167377ae797d84f325f3c584c41cc2a771\", \"flatbuffers_unittests\": \"3e3b6c7bf0c1182740cf5cce7088efe0220a77b5\", \"gcm_unit_tests\": \"fa08e70c568b05e36dabab84954395a29fba5742\", \"gfx_unittests\": \"3f79767f43f54b14950040d2cc3c7dcd608258ff\", \"gin_unittests\": \"b3ede00b09f31cc42d1e9e780211e033fe6da1f0\", \"google_apis_unittests\": \"f874436c63c19d11924b72dbaf0e5f3c08b0c3c0\", \"gpu_unittests\": \"a716c5315818f67f6f4ee50d700b067ced9777fa\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"eb637f3a13eb03112313b55bd0704e52b259b80a\", \"headless_browsertests\": \"98f7c904f0ee46de308b01a6683ef8f46e0fcd43\", \"headless_unittests\": \"4d4d4b2b7e3859e4c9c6ac1e5e59a8c45d2f2095\", \"interactive_ui_tests\": \"4e148b89b8d1c56daa51805da10cb8cb0ef9882a\", \"ipc_tests\": \"21fccf0cdc9526b017ebc6d8658eb931c5f1a18c\", \"jingle_unittests\": \"0cff35f89e3746070074a1cf160bf55903221b3a\", \"latency_unittests\": \"7ad0432b8596e8b9e19131ddd846c07ceb50bbde\", \"libjingle_xmpp_unittests\": \"e1844526df50eaed78a16532f440d233cc4fb6d0\", \"liburlpattern_unittests\": \"363a6c29ba829cd006604d2196e025941827e479\", \"media_blink_unittests\": \"688ed5325ed1bde546bb7c436da5f299c73bc073\", \"media_unittests\": \"5450fc83ed5fd557aa9df77ef9e3bd073cfc719d\", \"message_center_unittests\": \"2a615e334352d7c2fef5ffbb630a39d948d050bc\", \"metrics_python_tests\": \"20919438b8b1859eb03b43e8ef278c052aab24b3\", \"midi_unittests\": \"412f7646682c4b1414fcef5679408c2157401887\", \"mojo_core_unittests\": \"d3b119bc32e492b3f4ed77b37e2f04bde4e9981f\", \"mojo_unittests\": \"9cd3df5a63bd517c411b3800a46ab58d17283d6f\", \"nacl_helper_nonsfi_unittests\": \"d1beb11d216f5c414b163fa9ef8648c3dab5b598\", \"nacl_loader_unittests\": \"cf199bc89556a1c7a95ec3af654e0de1d9dfd1d0\", \"native_theme_unittests\": \"6513297e26e5517abb36d4b865830d255d263893\", \"net_unittests\": \"e3971dd2ec87a025749561322f5767323d419a42\", \"openscreen_unittests\": \"d0414849dd982fad2de5662383e4f36b6d844205\", \"pdf_unittests\": \"88c5bc6a2a5b503e00c404048f6c450f16d68e6a\", \"perfetto_unittests\": \"3e4451d762297739df2c2b66adef5c4a3839d172\", \"ppapi_unittests\": \"b5c95603412ae24eb01a21d13586377abbd119a0\", \"printing_unittests\": \"2c00fc91fd9010148434e0fc0ec4badbe56ed899\", \"remoting_unittests\": \"ea5bf321152bb7c4d993cb60717cb61eecc7ff17\", \"sandbox_linux_unittests\": \"e1f828a5986379f71ae1e391b8101d41a249f910\", \"service_manager_unittests\": \"2d197a557ac3520b4071ef181ef643a5d22f7919\", \"services_unittests\": \"a3ad8762fbb942d3b455b4a90fd2865b61af5f27\", \"shell_dialogs_unittests\": \"629f0c65e193161f4b327f3cc3c45374162796db\", \"skia_unittests\": \"84f414cd7bc7335204bb7f8919a452d031682066\", \"snapshot_unittests\": \"d85feba65c72ed34df98b8b050d84fe878fd7f05\", \"sql_unittests\": \"c6af750068a32384c7183c1cf43046eb172f74a0\", \"storage_unittests\": \"6830b25496514414799c1bf58e97dee84aceb55b\", \"sync_integration_tests\": \"5604300d888541cf5fa2687c55c672769afc9e31\", \"telemetry_gpu_unittests\": \"7becf030866d631efd667a731bd25ddfc4f4954d\", \"telemetry_perf_unittests\": \"fe5017e012a1c505b9988e5170e6a0b06f8621ad\", \"telemetry_unittests\": \"2c8761106775cb6874d7d5e4fe8e4c437ec1219e\", \"traffic_annotation_auditor_unittests\": \"ee191c71a2147f040c572dfa66bb436421851624\", \"ui_base_unittests\": \"f70ca1a8ec324bb7faa668a77daf547f3ca88a55\", \"ui_touch_selection_unittests\": \"b5ff60a746eb55ddcb3a3c0c75d8bb4e3d52412b\", \"unit_tests\": \"ab1a74ce672e37fd331fa7229496f12985492cc9\", \"url_unittests\": \"c72941b27660677f60d38e82bb451cbcb8fa3db4\", \"views_perftests\": \"9a20747624b191200e10e91e21cd055ddf70cbf5\", \"views_unittests\": \"a76ec9a8a5e8f68cd0438159f9fda0f888366e9f\", \"viz_unittests\": \"fa2e50c54e46ba53207eaeb7124ae5f2a45701dd\", \"vr_common_unittests\": \"9ae50197f9632c4723ed44fd96576e9d6cb9680e\", \"vr_pixeltests\": \"0a67e22e22a8216fbdb2e3baf2cea31f012ee86e\", \"webdriver_wpt_tests\": \"d022c069e461873c27725589e747b5f5ef2ceb95\", \"weblayer_browsertests\": \"04f8c38f6bc895b15c94c87a11afe89ec273196f\", \"weblayer_unittests\": \"71544bcf8c918cd02cdfbf20f60a10f7bdbccd26\", \"wm_unittests\": \"fbaa458b734c3bb2b8e93b817e4ee8e415d8b4ed\", \"wtf_unittests\": \"fd4ade3515f24e5cdcc9c0fb4aededf5b744e0ac\", \"x11_unittests\": \"4d8be0667b1abd9fee3082c8ef28ca5a3a02f37a\", \"xr_browser_tests\": \"1517fc7511ecb5cbe545d398fb18080ba5024be7\", \"zlib_unittests\": \"209b5b448597687f86dd4e3cc5fc012280a09ef5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_9864f67f40ba0a637f020c00db69aed5c54155e2e95bfe26df83308425415c7f_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-151-uukz\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614251315487644",
"status": "COMPLETED",
"status_changed_ts": "1614254834901032",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180921",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd4075b2d27aad795d41de1b3f10d9c3f70fdb77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019758598812991952",
"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/8854328536861766272/+/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:51f1b1bd4640fe10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614254834921353",
"url": "https://ci.chromium.org/b/8854328536861766272",
"utcnow_ts": "1614254835753409"
}
}
[12:07:15.776] Invocation finished in 58m49.441942304s with status SUCCEEDED