[10:03:02.658] New invocation is queued and will start shortly
[10:03:03.775] Starting the invocation (attempt 1)
[10:03:03.809] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:03:03.809] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:03:03.809] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019672116135761376",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"63714a9ffe267a0212f4120a188f45408555a993\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019672116135761376",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/63714a9ffe267a0212f4120a188f45408555a993",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63714a9ffe267a0212f4120a188f45408555a993",
"gitiles_ref:refs/heads/master"
]
}
[10:03:04.719] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614333783988581",
"id": "8854242054079736528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63714a9ffe267a0212f4120a188f45408555a993\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614333784583364",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180952",
"builder:Linux Builder (dbg)",
"buildset:commit/git/63714a9ffe267a0212f4120a188f45408555a993",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63714a9ffe267a0212f4120a188f45408555a993",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019672116135761376",
"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/8854242054079736528/+/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": "1614333784583586",
"url": "https://ci.chromium.org/b/8854242054079736528",
"utcnow_ts": "1614333784709622"
}
}
[10:03:04.719] Task URL: https://ci.chromium.org/b/8854242054079736528
[10:03:04.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:2:0) after 1m0s
[10:03:09.260] Received PubSub notification, asking Buildbucket for the build status
[10:03:09.364] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:04.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:2:0)
[10:04:04.707] Timer tick, asking Buildbucket for the build status
[10:04:04.911] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:04.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:4:0) after 1m0s
[10:05:04.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:4:0)
[10:05:04.960] Timer tick, asking Buildbucket for the build status
[10:05:05.054] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:05.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:5:0) after 1m0s
[10:06:05.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:5:0)
[10:06:05.153] Timer tick, asking Buildbucket for the build status
[10:06:05.229] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:05.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:6:0) after 1m0s
[10:07:05.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:6:0)
[10:07:05.296] Timer tick, asking Buildbucket for the build status
[10:07:05.498] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:05.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:7:0) after 1m0s
[10:08:05.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:7:0)
[10:08:05.522] Timer tick, asking Buildbucket for the build status
[10:08:05.661] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:05.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:8:0) after 1m0s
[10:09:05.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:8:0)
[10:09:05.711] Timer tick, asking Buildbucket for the build status
[10:09:05.808] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:05.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:9:0) after 1m0s
[10:10:05.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:9:0)
[10:10:05.876] Timer tick, asking Buildbucket for the build status
[10:10:05.950] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:05.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:10:0) after 1m0s
[10:11:05.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:10:0)
[10:11:05.963] Timer tick, asking Buildbucket for the build status
[10:11:06.036] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:06.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:11:0) after 1m0s
[10:12:06.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:11:0)
[10:12:06.043] Timer tick, asking Buildbucket for the build status
[10:12:06.171] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:06.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:12:0) after 1m0s
[10:13:06.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:12:0)
[10:13:06.185] Timer tick, asking Buildbucket for the build status
[10:13:06.629] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:06.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:13:0) after 1m0s
[10:14:06.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:13:0)
[10:14:06.644] Timer tick, asking Buildbucket for the build status
[10:14:06.809] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:06.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:14:0) after 1m0s
[10:15:06.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:14:0)
[10:15:06.826] Timer tick, asking Buildbucket for the build status
[10:15:07.072] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:15:0) after 1m0s
[10:16:07.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:15:0)
[10:16:07.103] Timer tick, asking Buildbucket for the build status
[10:16:07.170] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:07.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:16:0) after 1m0s
[10:17:07.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:16:0)
[10:17:07.167] Timer tick, asking Buildbucket for the build status
[10:17:07.238] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:07.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:17:0) after 1m0s
[10:18:07.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:17:0)
[10:18:07.239] Timer tick, asking Buildbucket for the build status
[10:18:07.371] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:07.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:18:0) after 1m0s
[10:19:07.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:18:0)
[10:19:07.422] Timer tick, asking Buildbucket for the build status
[10:19:07.495] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:07.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:19:0) after 1m0s
[10:20:07.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:19:0)
[10:20:07.498] Timer tick, asking Buildbucket for the build status
[10:20:07.656] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:07.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:20:0) after 1m0s
[10:21:07.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:20:0)
[10:21:07.671] Timer tick, asking Buildbucket for the build status
[10:21:07.969] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:07.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:21:0) after 1m0s
[10:22:07.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:21:0)
[10:22:07.971] Timer tick, asking Buildbucket for the build status
[10:22:08.055] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:08.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:22:0) after 1m0s
[10:23:08.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:22:0)
[10:23:08.074] Timer tick, asking Buildbucket for the build status
[10:23:08.164] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:08.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:23:0) after 1m0s
[10:24:08.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:23:0)
[10:24:08.159] Timer tick, asking Buildbucket for the build status
[10:24:08.264] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:08.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:24:0) after 1m0s
[10:25:08.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:24:0)
[10:25:08.278] Timer tick, asking Buildbucket for the build status
[10:25:08.497] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:08.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:25:0) after 1m0s
[10:26:08.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:25:0)
[10:26:08.626] Timer tick, asking Buildbucket for the build status
[10:26:08.854] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:08.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:26:0) after 1m0s
[10:27:09.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:26:0)
[10:27:09.529] Timer tick, asking Buildbucket for the build status
[10:27:09.600] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:09.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:27:0) after 1m0s
[10:28:09.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:27:0)
[10:28:09.628] Timer tick, asking Buildbucket for the build status
[10:28:09.742] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:28:0) after 1m0s
[10:29:09.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:28:0)
[10:29:09.759] Timer tick, asking Buildbucket for the build status
[10:29:09.857] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:09.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:29:0) after 1m0s
[10:30:09.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:29:0)
[10:30:09.855] Timer tick, asking Buildbucket for the build status
[10:30:09.923] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:09.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:30:0) after 1m0s
[10:31:09.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:30:0)
[10:31:09.944] Timer tick, asking Buildbucket for the build status
[10:31:10.256] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:10.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:31:0) after 1m0s
[10:32:10.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:31:0)
[10:32:10.298] Timer tick, asking Buildbucket for the build status
[10:32:10.532] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:10.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:32:0) after 1m0s
[10:33:10.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:32:0)
[10:33:10.569] Timer tick, asking Buildbucket for the build status
[10:33:10.716] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:10.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:33:0) after 1m0s
[10:34:10.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:33:0)
[10:34:10.778] Timer tick, asking Buildbucket for the build status
[10:34:10.870] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:10.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:34:0) after 1m0s
[10:35:10.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:34:0)
[10:35:10.895] Timer tick, asking Buildbucket for the build status
[10:35:10.999] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:10.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:35:0) after 1m0s
[10:36:11.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:35:0)
[10:36:11.062] Timer tick, asking Buildbucket for the build status
[10:36:11.132] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:36:0) after 1m0s
[10:37:11.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:36:0)
[10:37:11.190] Timer tick, asking Buildbucket for the build status
[10:37:11.308] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:11.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:37:0) after 1m0s
[10:38:11.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:37:0)
[10:38:11.350] Timer tick, asking Buildbucket for the build status
[10:38:11.470] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:38:0) after 1m0s
[10:39:11.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:38:0)
[10:39:11.535] Timer tick, asking Buildbucket for the build status
[10:39:11.600] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:11.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:39:0) after 1m0s
[10:40:11.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:39:0)
[10:40:11.659] Timer tick, asking Buildbucket for the build status
[10:40:11.736] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:11.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:40:0) after 1m0s
[10:41:11.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:40:0)
[10:41:11.714] Timer tick, asking Buildbucket for the build status
[10:41:11.794] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:11.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:41:0) after 1m0s
[10:42:11.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:41:0)
[10:42:11.845] Timer tick, asking Buildbucket for the build status
[10:42:11.923] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:11.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:42:0) after 1m0s
[10:43:12.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:42:0)
[10:43:12.008] Timer tick, asking Buildbucket for the build status
[10:43:12.113] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:12.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:43:0) after 1m0s
[10:44:12.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:43:0)
[10:44:12.134] Timer tick, asking Buildbucket for the build status
[10:44:12.351] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:12.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:44:0) after 1m0s
[10:45:12.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:44:0)
[10:45:12.438] Timer tick, asking Buildbucket for the build status
[10:45:12.704] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:12.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:45:0) after 1m0s
[10:46:12.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:45:0)
[10:46:12.751] Timer tick, asking Buildbucket for the build status
[10:46:12.890] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:12.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:46:0) after 1m0s
[10:47:12.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:46:0)
[10:47:12.958] Timer tick, asking Buildbucket for the build status
[10:47:13.135] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:13.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:47:0) after 1m0s
[10:48:13.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:47:0)
[10:48:13.154] Timer tick, asking Buildbucket for the build status
[10:48:13.357] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:13.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:48:0) after 1m0s
[10:49:13.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:48:0)
[10:49:13.377] Timer tick, asking Buildbucket for the build status
[10:49:13.454] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:13.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:49:0) after 1m0s
[10:50:14.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:49:0)
[10:50:14.517] Timer tick, asking Buildbucket for the build status
[10:50:14.857] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:14.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:50:0) after 1m0s
[10:51:14.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:50:0)
[10:51:14.998] Timer tick, asking Buildbucket for the build status
[10:51:15.141] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:15.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:51:0) after 1m0s
[10:52:15.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:51:0)
[10:52:15.203] Timer tick, asking Buildbucket for the build status
[10:52:15.545] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:52:0) after 1m0s
[10:53:15.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:52:0)
[10:53:15.630] Timer tick, asking Buildbucket for the build status
[10:53:15.712] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:15.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:53:0) after 1m0s
[10:54:15.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:53:0)
[10:54:15.683] Timer tick, asking Buildbucket for the build status
[10:54:15.763] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:15.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:54:0) after 1m0s
[10:55:15.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:54:0)
[10:55:15.860] Timer tick, asking Buildbucket for the build status
[10:55:15.943] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:15.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:55:0) after 1m0s
[10:56:16.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:55:0)
[10:56:16.018] Timer tick, asking Buildbucket for the build status
[10:56:16.105] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:16.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:56:0) after 1m0s
[10:57:16.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:56:0)
[10:57:16.125] Timer tick, asking Buildbucket for the build status
[10:57:16.198] Build 8854242054079736528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:16.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019672116135761376:57:0) after 1m0s
[10:57:51.730] Received PubSub notification, asking Buildbucket for the build status
[10:57:51.809] Build 8854242054079736528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:57:51.809] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614337070838074",
"created_by": "project:chromium",
"created_ts": "1614333783988581",
"id": "8854242054079736528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63714a9ffe267a0212f4120a188f45408555a993\"}}",
"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\": \"63714a9ffe267a0212f4120a188f45408555a993\", \"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-77-lyi8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180952, \"got_angle_revision\": \"d24398b3e36175d08e74261a1a0a2c8a27a00dd6\", \"got_dawn_revision\": \"87649ff09dee357f0412834527e4174b4989358f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"63714a9ffe267a0212f4120a188f45408555a993\", \"got_revision_cp\": \"refs/heads/master@{#858069}\", \"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\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"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\": \"63714a9ffe267a0212f4120a188f45408555a993\", \"swarm_hashes_refs/heads/master(at){#858069}_without_patch\": {\"absl_hardening_tests\": \"64db1c6bdda56d747660973fc46ce2a0bff4a183\", \"accessibility_unittests\": \"5349256792378bd7c3c3b5ca9db9ba846e0fef41\", \"angle_unittests\": \"7569518775f7bb05581bb874ad2c0f631a411295\", \"app_shell_unittests\": \"870a145120985c90af777e8c31749221d9d3aa60\", \"aura_unittests\": \"35c51b4a10ddb9d0aa4cb2d53a426b99dca02acb\", \"base_unittests\": \"889d5c812babc6944982500c55d1c6c086486a2d\", \"base_util_unittests\": \"53b86b66c4b35fef91373c40d0ec88c73298b74b\", \"blink_common_unittests\": \"f267925c7619435c5fcc372f6a21d878c6f95f04\", \"blink_fuzzer_unittests\": \"5d734a478715018751aa410890828c796f8b436f\", \"blink_heap_unittests\": \"e4452275558cdbbc42a0633d8eab07b551b32739\", \"blink_platform_unittests\": \"4ef80a26cf7c47bcd785ea20cbe0215bd7a3a0cb\", \"blink_python_tests\": \"2233f66c825d6a3ed3eaf6f6f45da7de03d9e57f\", \"blink_unittests\": \"2a454ed6c0772c1f96767b196225176921bb57cf\", \"blink_web_tests\": \"5f42fc586cc07e90fe22638b29644a5b70b50608\", \"boringssl_crypto_tests\": \"d3555008e711d34c7a90c0e7c7d597ba09fab4e8\", \"boringssl_ssl_tests\": \"f09343b0fe22157cf89831f46bc49dcf318b4169\", \"browser_tests\": \"c4e98c636b1944f582056932c6c492ca92d91adf\", \"capture_unittests\": \"611e9ca507f21d68e76ccbdd1417014169000d35\", \"cast_unittests\": \"88a2c6b99d9decce1943c45b02ec827fd368a05a\", \"cc_unittests\": \"0ae5a24bf16c1cc41121a318c2ac4f416c0dc060\", \"chrome_app_unittests\": \"b76e6a19d4c9670ca0915c7da35eafbaea35a209\", \"chromedriver_unittests\": \"6817838d7e3786d413b66a3c3cb927671b9d1641\", \"color_unittests\": \"4830c85feb972a47dbb284324624bcdb33b4f679\", \"components_browsertests\": \"e76de2fc06accb4d2c380d0d1310f1a118b1dcf9\", \"components_unittests\": \"ff170ff2f91f9f3f7e7f315c6fa0235e1c3a2077\", \"compositor_unittests\": \"572c4bcbcd08cb2641ab7a714a39457f6f123da3\", \"content_browsertests\": \"2bf8997fb109824c88679f107f0923aaddb9997f\", \"content_shell_crash_test\": \"51a126a13f796847ff91a8b384bacaa0d6ad88dc\", \"content_unittests\": \"cbb0e189a346a6457271705845800fa1cd75103b\", \"crashpad_tests\": \"16d4bb3653de863c9d177e62cd968a622a88a88f\", \"cronet_tests\": \"3e5f314accd523e27151bbdff28192b5d8719576\", \"cronet_unittests\": \"5e41ddc384867cb92e99b1c26a6cd433d8e0a1e8\", \"crypto_unittests\": \"3b902f05f03633949816604301a6cb2a4d620312\", \"dbus_unittests\": \"6542eaa03eafe6ef307e817f09339ab67392a2eb\", \"device_unittests\": \"388766f8d1edc866b194d6357cc38b86766e409a\", \"display_unittests\": \"8120f700db428fd60d0fab655f9bf3693a90cfe1\", \"events_unittests\": \"568981c9d9b969d4d464cce89479e4a7b57861bd\", \"extensions_browsertests\": \"6f3e569380f6ea0bbc9d34f931d2479e4b02caf7\", \"extensions_unittests\": \"88ead7a95f7b8b3be6a8d3f12fcfe53cb962127c\", \"filesystem_service_unittests\": \"8521b729f15ccc6fcadb8ec37488cebe284535bb\", \"flatbuffers_unittests\": \"3e3b6c7bf0c1182740cf5cce7088efe0220a77b5\", \"gcm_unit_tests\": \"0b4cdf86ec3bf9b96dc74cecd5367eada75b1972\", \"gfx_unittests\": \"516158ed6432f001f1ca14fca64c16e35e50cf66\", \"gin_unittests\": \"794be52ca2d152dc92203eff4433b243ddfa98fb\", \"google_apis_unittests\": \"6ebdcb7d12be6e55a230e1a7a27b0387122e73ef\", \"gpu_unittests\": \"6398a92213712dec12d7acff27a941a96265510f\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"2246c8653fde953b5dc600d11e2ddf2bd0ad0625\", \"headless_browsertests\": \"5790abe4e7af41180691c2a227f7851bdac82655\", \"headless_unittests\": \"38a3a5cb336a444c17d3b710f6824eb650c3cb34\", \"interactive_ui_tests\": \"c934c415c8605adbd544cc663c176e7f6309dce2\", \"ipc_tests\": \"bf86bad91eff009063a476faf52cad6b234e22f6\", \"jingle_unittests\": \"c43b52ace73c3e7f7b59e4d989533b856e902fa9\", \"latency_unittests\": \"3f8d15c186582be6b9a1496d049d8bea431929a7\", \"libjingle_xmpp_unittests\": \"327ba6c4fd3cd27b27b2e8ea90755e9b15d1f4db\", \"liburlpattern_unittests\": \"ca3f9234f6919bfaafcda576938da02b81f02869\", \"media_blink_unittests\": \"1c75f41914fa6a617bdcab7a3844e56d00aa9dfe\", \"media_unittests\": \"05b8b57eb0a55dae4912664172607153a14b5f21\", \"message_center_unittests\": \"b48f0a19db2ab43380ae19a084d2cea9bad92a47\", \"metrics_python_tests\": \"26be3fca38b3afdee4884d7399d36fab3ddd1471\", \"midi_unittests\": \"78c75a4b8c87592667c6c75350f4ba09e4d28716\", \"mojo_core_unittests\": \"a2c58514c7ce45b342c9b77271cd990d5fe04721\", \"mojo_unittests\": \"27c8c9c3589d9764d0992cd4ae83f02b8a5716b6\", \"nacl_helper_nonsfi_unittests\": \"b159ee377c651e686f44956a7f03d8bf28d3c25b\", \"nacl_loader_unittests\": \"ee0ae1fbbf7de38e864605e60d0e7db019c34341\", \"native_theme_unittests\": \"6bade16e25b8a82e25f678c0e68fb557457535ab\", \"net_unittests\": \"50742ebf3b7296da70df5a888adee964714d176a\", \"openscreen_unittests\": \"4259e2c1eda0a85e28dd7cc327767e549d323731\", \"pdf_unittests\": \"43cc7d627d9854465cee3ef0404d74c268bac299\", \"perfetto_unittests\": \"320e710c7b7d2d2deccd2bb4f6ffa772625f857e\", \"ppapi_unittests\": \"f99ef5bb0d0a8a88604ec3533ec005f684ced0a3\", \"printing_unittests\": \"7642ed52e351247c872e1d8941f5d4b904fd6249\", \"remoting_unittests\": \"db25b21c26c1b86d8e4da3a2d84ef5e67754c1cd\", \"sandbox_linux_unittests\": \"7f253001ac595c98cb03cc5e64584ffc2f7110b9\", \"service_manager_unittests\": \"b978ee2b53e5a36383f77f5903458c91e68291a1\", \"services_unittests\": \"6f053de1b7c5fc754138cde15deee2d243914a4b\", \"shell_dialogs_unittests\": \"7799ae6471f7000b143371f23286263c5e727d7f\", \"skia_unittests\": \"5f3f692a4505a5982806ffdd9a4d8e7e6425bb54\", \"snapshot_unittests\": \"68d76dce788bfa6e7cce39315af4bc04aa2e3271\", \"sql_unittests\": \"e842f7f4bfe68ddeb81a28a38fdb21985bb210c2\", \"storage_unittests\": \"cc4a450764e9e28a787e969efa39691b7028cf2c\", \"sync_integration_tests\": \"b28733a6e8741e0e4a1cda5d5a28708a7deb5c48\", \"telemetry_gpu_unittests\": \"e1ce36f55c0746231357ed9ebef5a403c4136cd0\", \"telemetry_perf_unittests\": \"b693c34124780a441d853b2c2b100f442f7b735d\", \"telemetry_unittests\": \"e402961b4e3cdcaddf20cc46e06f0633e4d0e3c3\", \"traffic_annotation_auditor_unittests\": \"af63b3a6104b78d34fd74d951c3ae90d9e2795c2\", \"ui_base_unittests\": \"4fd5fb33c8c6839a12db1bc49bf4b1d7e7d10d55\", \"ui_touch_selection_unittests\": \"7ef648dc3698c7a648b35417c7da03b9d983c0c5\", \"unit_tests\": \"7a9f12bdbb7b365dd2249e4b9c46e831b0fdb1d1\", \"url_unittests\": \"4901f40ede34e333423ec1b44241a126977e1e2e\", \"views_perftests\": \"5c28e2bd34772debb92cd598d897c70f85d5aa66\", \"views_unittests\": \"b62caf7472592256dd0fcddd0ce65f9d6131c53b\", \"viz_unittests\": \"a97f41b56e89ed8d818402df9d8f5d2c3f7e59ba\", \"vr_common_unittests\": \"ec6ea22b496fe49e40ddd6f9605300290e30c269\", \"vr_pixeltests\": \"3470da2a713f01f511e53d057cec2b399544aa98\", \"webdriver_wpt_tests\": \"b9cd99db77031fd915f28294969925a764e9f7f5\", \"weblayer_browsertests\": \"3f231aaa3c793d6dc70fb26f5764dfbb6e0cd4fe\", \"weblayer_unittests\": \"fec2bf8171b3bc25dd4134e3cf4345b66e4dcb0d\", \"wm_unittests\": \"b59d54fe95e717f6ade55b4bd74b22ccc65d7ff0\", \"wtf_unittests\": \"48f4ffacf70039d40ecc4d03392aa32cb7eed942\", \"x11_unittests\": \"37087af11dd423b3a84251c1b3dd550e742b3b57\", \"xr_browser_tests\": \"cec06c1e3f37d28ecc1a128ae7eb8b6e708a8879\", \"zlib_unittests\": \"d7c689276110d95fb718637733f14e2a0140630d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_158d0f10fa5d87b7b90de0551ce233e88e46559602c021beec49ce89728c3318_v2\", \"builder_554b324272771ff5af13275cc9c865b3499df108d1c4d159c356d5c678bf725c_v2\", \"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_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-77-lyi8\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614333788024837",
"status": "COMPLETED",
"status_changed_ts": "1614337071131223",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180952",
"builder:Linux Builder (dbg)",
"buildset:commit/git/63714a9ffe267a0212f4120a188f45408555a993",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63714a9ffe267a0212f4120a188f45408555a993",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019672116135761376",
"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/8854242054079736528/+/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:51f69c3b8fd6d710",
"user_agent:luci-scheduler"
],
"updated_ts": "1614337071136175",
"url": "https://ci.chromium.org/b/8854242054079736528",
"utcnow_ts": "1614337071797285"
}
}
[10:57:51.809] Invocation finished in 54m49.166851659s with status SUCCEEDED