[09:08:54.446] New invocation is queued and will start shortly
[09:08:55.545] Starting the invocation (attempt 1)
[09:08:55.585] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:08:55.585] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:08:55.585] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054011772404231648",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f78bd037011b88c648d5c46ffa5031295ac2cc61\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054011772404231648",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"gitiles_ref:refs/heads/master"
]
}
[09:08:57.576] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581584936218346",
"id": "8888581709879040064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f78bd037011b88c648d5c46ffa5031295ac2cc61\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581584937218222",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168549",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054011772404231648",
"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/8888581709879040064/+/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": "1581584937218392",
"url": "https://ci.chromium.org/b/8888581709879040064",
"utcnow_ts": "1581584937567778"
}
}
[09:08:57.577] Task URL: https://ci.chromium.org/b/8888581709879040064
[09:08:57.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:2:0) after 1m0s
[09:09:57.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:2:0)
[09:09:57.565] Timer tick, asking Buildbucket for the build status
[09:09:58.030] Build 8888581709879040064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:58.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:3:0) after 1m0s
[09:10:58.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:3:0)
[09:10:58.041] Timer tick, asking Buildbucket for the build status
[09:10:58.485] Build 8888581709879040064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:58.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:4:0) after 1m0s
[09:11:58.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:4:0)
[09:11:58.538] Timer tick, asking Buildbucket for the build status
[09:11:58.680] Build 8888581709879040064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:58.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:5:0) after 1m0s
[09:12:58.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:5:0)
[09:12:58.686] Timer tick, asking Buildbucket for the build status
[09:12:58.813] Build 8888581709879040064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:58.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:6:0) after 1m0s
[09:13:58.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:6:0)
[09:13:58.841] Timer tick, asking Buildbucket for the build status
[09:13:59.239] Build 8888581709879040064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:59.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:7:0) after 1m0s
[09:13:59.592] Received PubSub notification, asking Buildbucket for the build status
[09:13:59.715] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:59.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:7:0)
[09:14:59.254] Timer tick, asking Buildbucket for the build status
[09:14:59.393] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:59.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:9:0) after 1m0s
[09:15:59.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:9:0)
[09:15:59.439] Timer tick, asking Buildbucket for the build status
[09:15:59.775] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:59.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:10:0) after 1m0s
[09:16:59.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:10:0)
[09:16:59.806] Timer tick, asking Buildbucket for the build status
[09:16:59.989] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:59.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:11:0) after 1m0s
[09:18:00.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:11:0)
[09:18:00.021] Timer tick, asking Buildbucket for the build status
[09:18:00.306] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:00.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:12:0) after 1m0s
[09:19:00.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:12:0)
[09:19:00.367] Timer tick, asking Buildbucket for the build status
[09:19:00.530] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:13:0) after 1m0s
[09:20:00.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:13:0)
[09:20:00.655] Timer tick, asking Buildbucket for the build status
[09:20:00.813] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:00.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:14:0) after 1m0s
[09:21:01.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:14:0)
[09:21:01.021] Timer tick, asking Buildbucket for the build status
[09:21:01.187] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:01.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:15:0) after 1m0s
[09:22:01.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:15:0)
[09:22:01.227] Timer tick, asking Buildbucket for the build status
[09:22:01.461] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:01.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:16:0) after 1m0s
[09:23:01.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:16:0)
[09:23:01.777] Timer tick, asking Buildbucket for the build status
[09:23:02.389] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:02.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:17:0) after 1m0s
[09:24:02.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:17:0)
[09:24:02.446] Timer tick, asking Buildbucket for the build status
[09:24:02.583] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:02.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:18:0) after 1m0s
[09:25:02.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:18:0)
[09:25:02.628] Timer tick, asking Buildbucket for the build status
[09:25:03.268] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:19:0) after 1m0s
[09:26:03.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:19:0)
[09:26:03.379] Timer tick, asking Buildbucket for the build status
[09:26:03.665] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:03.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:20:0) after 1m0s
[09:27:03.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:20:0)
[09:27:03.858] Timer tick, asking Buildbucket for the build status
[09:27:04.338] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:21:0) after 1m0s
[09:28:04.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:21:0)
[09:28:04.405] Timer tick, asking Buildbucket for the build status
[09:28:04.950] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:04.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:22:0) after 1m0s
[09:29:05.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:22:0)
[09:29:05.200] Timer tick, asking Buildbucket for the build status
[09:29:05.349] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:05.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:23:0) after 1m0s
[09:30:05.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:23:0)
[09:30:05.497] Timer tick, asking Buildbucket for the build status
[09:30:05.877] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:05.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:24:0) after 1m0s
[09:31:06.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:24:0)
[09:31:06.170] Timer tick, asking Buildbucket for the build status
[09:31:06.342] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:06.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:25:0) after 1m0s
[09:32:06.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:25:0)
[09:32:06.494] Timer tick, asking Buildbucket for the build status
[09:32:06.650] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:06.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:26:0) after 1m0s
[09:33:06.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:26:0)
[09:33:06.832] Timer tick, asking Buildbucket for the build status
[09:33:06.965] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:06.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:27:0) after 1m0s
[09:34:07.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:27:0)
[09:34:07.034] Timer tick, asking Buildbucket for the build status
[09:34:07.201] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:07.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:28:0) after 1m0s
[09:35:07.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:28:0)
[09:35:07.333] Timer tick, asking Buildbucket for the build status
[09:35:07.522] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:07.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:29:0) after 1m0s
[09:36:07.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:29:0)
[09:36:07.600] Timer tick, asking Buildbucket for the build status
[09:36:08.882] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:08.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:30:0) after 1m0s
[09:37:09.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:30:0)
[09:37:09.076] Timer tick, asking Buildbucket for the build status
[09:37:09.225] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:09.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:31:0) after 1m0s
[09:38:09.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:31:0)
[09:38:09.264] Timer tick, asking Buildbucket for the build status
[09:38:10.165] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:10.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:32:0) after 1m0s
[09:39:10.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:32:0)
[09:39:10.190] Timer tick, asking Buildbucket for the build status
[09:39:10.552] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:10.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:33:0) after 1m0s
[09:40:10.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:33:0)
[09:40:10.714] Timer tick, asking Buildbucket for the build status
[09:40:12.265] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:12.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:34:0) after 1m0s
[09:41:12.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:34:0)
[09:41:12.292] Timer tick, asking Buildbucket for the build status
[09:41:12.579] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:12.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:35:0) after 1m0s
[09:42:12.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:35:0)
[09:42:12.662] Timer tick, asking Buildbucket for the build status
[09:42:12.822] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:12.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:36:0) after 1m0s
[09:43:12.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:36:0)
[09:43:12.893] Timer tick, asking Buildbucket for the build status
[09:43:13.980] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:13.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:37:0) after 1m0s
[09:44:14.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:37:0)
[09:44:14.009] Timer tick, asking Buildbucket for the build status
[09:44:14.151] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:14.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:38:0) after 1m0s
[09:45:14.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:38:0)
[09:45:14.259] Timer tick, asking Buildbucket for the build status
[09:45:14.394] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:14.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:39:0) after 1m0s
[09:46:14.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:39:0)
[09:46:14.521] Timer tick, asking Buildbucket for the build status
[09:46:14.717] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:40:0) after 1m0s
[09:47:14.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:40:0)
[09:47:14.779] Timer tick, asking Buildbucket for the build status
[09:47:14.953] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:41:0) after 1m0s
[09:48:15.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:41:0)
[09:48:15.029] Timer tick, asking Buildbucket for the build status
[09:48:15.174] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:15.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:42:0) after 1m0s
[09:49:15.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:42:0)
[09:49:15.235] Timer tick, asking Buildbucket for the build status
[09:49:15.391] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:15.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:43:0) after 1m0s
[09:50:15.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:43:0)
[09:50:15.451] Timer tick, asking Buildbucket for the build status
[09:50:16.267] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:16.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:44:0) after 1m0s
[09:51:16.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:44:0)
[09:51:16.324] Timer tick, asking Buildbucket for the build status
[09:51:16.748] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:16.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:45:0) after 1m0s
[09:52:16.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:45:0)
[09:52:16.772] Timer tick, asking Buildbucket for the build status
[09:52:16.937] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:16.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:46:0) after 1m0s
[09:53:17.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:46:0)
[09:53:17.004] Timer tick, asking Buildbucket for the build status
[09:53:18.227] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:18.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:47:0) after 1m0s
[09:54:18.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:47:0)
[09:54:18.253] Timer tick, asking Buildbucket for the build status
[09:54:18.400] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:18.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:48:0) after 1m0s
[09:55:18.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:48:0)
[09:55:18.494] Timer tick, asking Buildbucket for the build status
[09:55:18.815] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:18.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:49:0) after 1m0s
[09:56:18.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:49:0)
[09:56:18.888] Timer tick, asking Buildbucket for the build status
[09:56:19.747] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:19.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:50:0) after 1m0s
[09:57:19.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:50:0)
[09:57:19.793] Timer tick, asking Buildbucket for the build status
[09:57:19.929] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:19.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:51:0) after 1m0s
[09:58:19.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:51:0)
[09:58:19.952] Timer tick, asking Buildbucket for the build status
[09:58:20.512] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:20.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:52:0) after 1m0s
[09:59:20.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:52:0)
[09:59:20.535] Timer tick, asking Buildbucket for the build status
[09:59:20.706] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:20.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:53:0) after 1m0s
[10:00:20.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:53:0)
[10:00:20.760] Timer tick, asking Buildbucket for the build status
[10:00:21.363] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:21.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:54:0) after 1m0s
[10:01:21.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:54:0)
[10:01:21.424] Timer tick, asking Buildbucket for the build status
[10:01:22.079] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:22.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:55:0) after 1m0s
[10:02:22.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:55:0)
[10:02:22.149] Timer tick, asking Buildbucket for the build status
[10:02:23.376] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:23.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:56:0) after 1m0s
[10:03:23.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:56:0)
[10:03:23.416] Timer tick, asking Buildbucket for the build status
[10:03:23.544] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:23.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:57:0) after 1m0s
[10:04:23.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:57:0)
[10:04:23.604] Timer tick, asking Buildbucket for the build status
[10:04:23.763] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:58:0) after 1m0s
[10:05:23.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:58:0)
[10:05:23.851] Timer tick, asking Buildbucket for the build status
[10:05:24.099] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:24.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:59:0) after 1m0s
[10:06:24.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:59:0)
[10:06:24.143] Timer tick, asking Buildbucket for the build status
[10:06:24.768] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:24.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:60:0) after 1m0s
[10:07:24.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:60:0)
[10:07:24.863] Timer tick, asking Buildbucket for the build status
[10:07:25.038] Build 8888581709879040064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:25.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054011772404231648:61:0) after 1m0s
[10:08:13.064] Received PubSub notification, asking Buildbucket for the build status
[10:08:13.280] Build 8888581709879040064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:08:13.280] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581588463880996",
"created_by": "project:chromium",
"created_ts": "1581584936218346",
"id": "8888581709879040064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f78bd037011b88c648d5c46ffa5031295ac2cc61\"}}",
"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\"}, \"$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-133-nn7v\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168549, \"got_angle_revision\": \"74ab0bffb526308f9732c99c7efc59fd718ee89c\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f78bd037011b88c648d5c46ffa5031295ac2cc61\", \"got_revision_cp\": \"refs/heads/master@{#740991}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"ac4e1d236088f90e3bc97aa67002ffe56042e4f2\", \"got_v8_revision\": \"acf9c0def690e10a2dc454d0c0aab1ff73ec7cee\", \"got_v8_revision_cp\": \"refs/heads/8.2.67@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f78bd037011b88c648d5c46ffa5031295ac2cc61\", \"swarm_hashes_refs/heads/master(at){#740991}_without_patch\": {\"accessibility_unittests\": \"c0bb51bc4b4f1ca1f5f95d64883dc92ce2c334fe\", \"angle_unittests\": \"efb5931af0200ba68c6a765b295b3e4421b57602\", \"app_shell_unittests\": \"6bf8ac74321fa66a4d49363361b4f409ad4fb484\", \"aura_unittests\": \"d81b5ea0b82e0806efa404615453b624c99531d7\", \"base_unittests\": \"cd70d6144e3238b8047ce9058a2938f01fb1271c\", \"base_util_unittests\": \"e17668784acbfa58b724b1c3f35cf3c631b506e7\", \"blink_common_unittests\": \"cb12719a6df215529807594ecb5fe9a64657f1cb\", \"blink_fuzzer_unittests\": \"2e544ff49e4f3e3ccfaa2cf701d8f2966d3e7387\", \"blink_heap_unittests\": \"8d6be16c17ec16d63a9a3561e71584bd71f93db4\", \"blink_platform_unittests\": \"5124dc6ae03446c49128c35fdf5354cfc506c6f5\", \"blink_python_tests\": \"f5f0a33acd327f5bd3a10c5dadfbd19321cc8381\", \"blink_unittests\": \"ffb905f64fbc4e621e1e3715241984706e1adf48\", \"blink_web_tests\": \"27c1fdb35f4538fbdd3d68a6fa6c3a04cc14c513\", \"boringssl_crypto_tests\": \"b87a055c98d697df135e48b0c23327df3468e283\", \"boringssl_ssl_tests\": \"98d469f6f38158412495b377357c0d4ac7d11c97\", \"browser_tests\": \"2fcc83827eb7864a4268e2abcc38e833ab7a27b2\", \"cacheinvalidation_unittests\": \"63312ec567db8c629f743fe998eddfda58183bcb\", \"capture_unittests\": \"02421b4291daf3a29069b6770cba95ab4ad20712\", \"cast_unittests\": \"5d0d3e2138432a166f64e83796df43666ccd204a\", \"cc_unittests\": \"f9479aa512c86cca774610a2aa58e6216699005f\", \"chrome_app_unittests\": \"1616ed2a451909f219ab65ea3d46116e68a510b8\", \"chromedriver_unittests\": \"49bd68677999b5f46a5ef8e71a805d144c6158b3\", \"components_browsertests\": \"db604306914dd2cf3b5af1027a27457326da8361\", \"components_unittests\": \"93ac8d302d747fc63bf4445100d17ebfb69ee50e\", \"compositor_unittests\": \"99594fefe28b78305c432515dba828b53a8c9629\", \"content_browsertests\": \"7f2f58cb41f59f32b33005f0232835602c67a21b\", \"content_shell_crash_test\": \"1f563ae3b4c39d942bde8263ca9ceea0bb7e6f42\", \"content_unittests\": \"61d660cc5e80283d8c6d6574376b5d544cd85078\", \"crashpad_tests\": \"e12d70617f5414d5734e54cf7cf7e76a1c138961\", \"cronet_tests\": \"79b573ab7e61fa56e861a64675addb7c62b649bb\", \"cronet_unittests\": \"43c209b02b32f917f5fa3c6b0733c8981fbe00e3\", \"crypto_unittests\": \"1924ae41beaaf91a8b7d97335bdd1bbe1751d70e\", \"dbus_unittests\": \"bab92fd98e2699ee4ede963aac0c36b8ee990add\", \"device_unittests\": \"e5e8067e730625eae6a50e4280466114035775be\", \"display_unittests\": \"3cd30a0306914ec325a17f4af0dbd3ebdf348766\", \"events_unittests\": \"e1339357f44f921e8b2358472314e3211303cae2\", \"extensions_browsertests\": \"b9c4a6022cb885ddf168c5aac36212bad536eebd\", \"extensions_unittests\": \"e8000c66b00d2f5f37e37a5ba550990f8f2b68fa\", \"filesystem_service_unittests\": \"c8651e8a37b5c3cdb2c131085bf84931d3c0986e\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"6954ecea658bfdf0b372edeb6139f93e7c7b5039\", \"gfx_unittests\": \"871b5b63181dda4c9680e52894dbbc143976af77\", \"gin_unittests\": \"210e2288bf878bc7c25cf7874870ca57085e579f\", \"google_apis_unittests\": \"031583f04c68880bc309457c269359fe87a6accc\", \"gpu_unittests\": \"52b50b44b3a254f5ea4031b1dfe4a28827f16cdf\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"fab8b58188083ab0d7ea803f315934d46c509def\", \"headless_browsertests\": \"41cd8d80526c66d1ffee86930fe5ea8d89ccd7b0\", \"headless_unittests\": \"53bef4c787c4c34c377b2ebaef00cbb780f61d15\", \"interactive_ui_tests\": \"250d3990bc5bba7b17ff0048fbb68a1d2ad8c634\", \"ipc_tests\": \"01503b4e1ac71543302751a4936bf3e0aee4a3ee\", \"jingle_unittests\": \"c3d7fc83cab596d413061e409801812df49dacc3\", \"latency_unittests\": \"374d318910c48e6bd82212f5886b8a2b5cec5544\", \"libjingle_xmpp_unittests\": \"3470d7d77992d659dc720d8bce96b5fd0e7edb14\", \"media_blink_unittests\": \"f9f98f54c1114a112ee35b1093daaa6988f9b247\", \"media_service_unittests\": \"f20372063d9682fc83e49a2706c9d386e5dc7c4c\", \"media_unittests\": \"dbe20e7c8d12bec2975bd929937550e0e1bce0ed\", \"message_center_unittests\": \"55f5fece8b70750880cfb073d683025e5de130f2\", \"metrics_python_tests\": \"b114164a4fdae8e81f4b5e0d4d9df8f0b90b7564\", \"midi_unittests\": \"220f68d93f7faf1c351dc0de8c9e177d8b4c6ecb\", \"mojo_core_unittests\": \"37d934fe119ab7e718daeca692ae912773e6bf51\", \"mojo_unittests\": \"0d09bb1ed182aa292b3ac6ca360038905c043df6\", \"nacl_helper_nonsfi_unittests\": \"1b7c37e43aa25cebc010dee06effda0066402797\", \"nacl_loader_unittests\": \"fc70d30d88f7d5fd4b10508e87d94b4f251e6db6\", \"native_theme_unittests\": \"996b404c42ebda6a2d53c1737c7985601db6db0e\", \"net_unittests\": \"392cf02973270e6de4de42e98c47677bf4e4107d\", \"pdf_unittests\": \"d43880a371041d42095881713c65801890be2cfa\", \"perfetto_unittests\": \"0f93b3731a0153693ce3cb7e8c33dce71004662d\", \"ppapi_unittests\": \"3e80723fa7b4c410caae488514e3b4f430028ce3\", \"printing_unittests\": \"eca495079abae9ae268091d19f6380c44ea103e5\", \"remoting_unittests\": \"105e1b2cf46b0ea4721b3379144c8fce1cc1ac3f\", \"sandbox_linux_unittests\": \"c954623bc4b652987c727c1e551e31948f025985\", \"service_manager_unittests\": \"6f02d85b59f96fb3e3474efe5fa394616c4fc10a\", \"services_unittests\": \"0193c8c46200ca6e8b5d4b1cf821c641768e7cc8\", \"shell_dialogs_unittests\": \"21c478442d33bb8ca194d1212648339dde84279f\", \"skia_unittests\": \"a0c203fe0b32824339222bbf78859291fa945a15\", \"snapshot_unittests\": \"c1ed10a24c5548e2c6c8571f87aadd7077875496\", \"sql_unittests\": \"8b93b52ade2ec6ac586908db0d2057e13fc6e8ae\", \"storage_unittests\": \"e4efaecc9d083703385d4930ccbf38475021b24d\", \"sync_integration_tests\": \"74a67e5d9d60369d727006753626ec1c64529208\", \"telemetry_gpu_unittests\": \"fc8e1b6ce5e9ed6b1c5e9ff857dd085ea79f99f3\", \"telemetry_perf_unittests\": \"1adc324041d3238517b1e622bc3c49f6f55657a1\", \"telemetry_unittests\": \"0e6a23b7425d4b7d1af8ee80a6a5a3ce47302d2e\", \"traffic_annotation_auditor_unittests\": \"a88862794e0672dce1e4f5f9039cfdd5ce635821\", \"ui_base_unittests\": \"4543a028da229047ac688719da18459eeb40f622\", \"ui_touch_selection_unittests\": \"e1709f3ea31c86ab3b5c533615d8c73b57f450db\", \"unit_tests\": \"75d6dcc1805297987d0ba20e14de1c97a6b11032\", \"url_unittests\": \"824719361fa5bd4f352953d4e1866ef4e9a69901\", \"views_perftests\": \"e398f5fe424ae1837db2d2bc3058d47636def8ef\", \"views_unittests\": \"423c50697ec2205842544d5cc4ac71c1bdf4d2f8\", \"viz_unittests\": \"4485986325d783004d4121c0217566959d19d179\", \"vr_common_unittests\": \"535d892c994d2803433329c1ff281e7fe3fe758d\", \"vr_pixeltests\": \"e12ef5a5109b74ecb497e6bc9ae957677373ce59\", \"webdriver_wpt_tests\": \"ba779e48820cfa50efd26182bb9a1f6e4f2df15d\", \"weblayer_browsertests\": \"250c7095121ab648146aa2884f71c3ef227229df\", \"wm_unittests\": \"b1fbe1d51a998c349eb4902fe0a5df390df6524a\", \"wtf_unittests\": \"eb9903a41bb7076287ee9ec00cd46744e8cc4fd9\", \"xr_browser_tests\": \"2cdbfc50e65dad61588c19d8eb09bff1fd89232f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0cd6cf41ec42413cc9e5bdc0dde565dc7bee061bff1a52db1e25d07760950df7_v2\", \"builder_1c97ebbcfb2b59a51287991f2ed562e10321e4784ed0e8a7a3677e8f006ec0dd_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_43913798ffe4aacc9db317de63924a4a199b83672551513d069405cf6f3bc584_v2\", \"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"builder_f5529a61c4772e2a2b7c80424c65e6b688bd4755892e8f82a67b8d7980cd8e00_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-133-nn7v\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581585199134500",
"status": "COMPLETED",
"status_changed_ts": "1581588492684572",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168549",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f78bd037011b88c648d5c46ffa5031295ac2cc61",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054011772404231648",
"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/8888581709879040064/+/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:4a56a07aed96d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1581588492689200",
"url": "https://ci.chromium.org/b/8888581709879040064",
"utcnow_ts": "1581588493244223"
}
}
[10:08:13.280] Invocation finished in 59m18.853573269s with status SUCCEEDED