[05:38:04.605] New invocation is queued and will start shortly
[05:38:05.687] Starting the invocation (attempt 1)
[05:38:05.723] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:38:05.723] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:38:05.723] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057830109307777376",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5c5105c2eb2d73ae29444716ceae055ded53f5da\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9057830109307777376",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"gitiles_ref:refs/heads/master"
]
}
[05:38:06.756] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577943486038221",
"id": "8892400047142648256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5c5105c2eb2d73ae29444716ceae055ded53f5da\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577943486590859",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166844",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057830109307777376",
"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/8892400047142648256/+/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": "1577943486591006",
"url": "https://ci.chromium.org/b/8892400047142648256",
"utcnow_ts": "1577943486743921"
}
}
[05:38:06.756] Task URL: https://ci.chromium.org/b/8892400047142648256
[05:38:06.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:2:0) after 1m0s
[05:39:11.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:2:0)
[05:39:11.650] Timer tick, asking Buildbucket for the build status
[05:39:12.377] Build 8892400047142648256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:12.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:3:0) after 1m0s
[05:40:12.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:3:0)
[05:40:12.377] Timer tick, asking Buildbucket for the build status
[05:40:13.455] Build 8892400047142648256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:13.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:4:0) after 1m0s
[05:41:13.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:4:0)
[05:41:13.487] Timer tick, asking Buildbucket for the build status
[05:41:13.634] Build 8892400047142648256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:13.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:5:0) after 1m0s
[05:42:13.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:5:0)
[05:42:13.661] Timer tick, asking Buildbucket for the build status
[05:42:14.840] Build 8892400047142648256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:6:0) after 1m0s
[05:43:02.859] Received PubSub notification, asking Buildbucket for the build status
[05:43:03.738] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:14.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:6:0)
[05:43:14.922] Timer tick, asking Buildbucket for the build status
[05:43:16.022] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:8:0) after 1m0s
[05:44:16.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:8:0)
[05:44:16.064] Timer tick, asking Buildbucket for the build status
[05:44:16.227] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:16.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:9:0) after 1m0s
[05:45:16.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:9:0)
[05:45:16.281] Timer tick, asking Buildbucket for the build status
[05:45:16.573] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:16.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:10:0) after 1m0s
[05:46:16.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:10:0)
[05:46:16.590] Timer tick, asking Buildbucket for the build status
[05:46:17.231] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:11:0) after 1m0s
[05:47:17.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:11:0)
[05:47:17.262] Timer tick, asking Buildbucket for the build status
[05:47:17.991] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:17.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:12:0) after 1m0s
[05:48:18.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:12:0)
[05:48:18.019] Timer tick, asking Buildbucket for the build status
[05:48:18.244] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:18.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:13:0) after 1m0s
[05:49:18.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:13:0)
[05:49:18.309] Timer tick, asking Buildbucket for the build status
[05:49:19.664] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:19.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:14:0) after 1m0s
[05:50:19.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:14:0)
[05:50:19.695] Timer tick, asking Buildbucket for the build status
[05:50:20.143] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:20.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:15:0) after 1m0s
[05:51:20.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:15:0)
[05:51:20.187] Timer tick, asking Buildbucket for the build status
[05:51:20.370] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:20.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:16:0) after 1m0s
[05:52:20.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:16:0)
[05:52:20.399] Timer tick, asking Buildbucket for the build status
[05:52:20.639] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:20.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:17:0) after 1m0s
[05:53:20.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:17:0)
[05:53:20.665] Timer tick, asking Buildbucket for the build status
[05:53:21.078] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:21.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:18:0) after 1m0s
[05:54:21.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:18:0)
[05:54:21.172] Timer tick, asking Buildbucket for the build status
[05:54:21.434] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:21.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:19:0) after 1m0s
[05:55:21.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:19:0)
[05:55:21.451] Timer tick, asking Buildbucket for the build status
[05:55:22.472] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:22.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:20:0) after 1m0s
[05:56:22.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:20:0)
[05:56:22.579] Timer tick, asking Buildbucket for the build status
[05:56:22.881] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:22.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:21:0) after 1m0s
[05:57:22.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:21:0)
[05:57:22.973] Timer tick, asking Buildbucket for the build status
[05:57:23.158] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:23.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:22:0) after 1m0s
[05:58:23.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:22:0)
[05:58:23.270] Timer tick, asking Buildbucket for the build status
[05:58:23.445] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:23.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:23:0) after 1m0s
[05:59:23.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:23:0)
[05:59:23.548] Timer tick, asking Buildbucket for the build status
[05:59:23.755] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:23.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:24:0) after 1m0s
[06:00:23.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:24:0)
[06:00:23.802] Timer tick, asking Buildbucket for the build status
[06:00:24.097] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:24.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:25:0) after 1m0s
[06:01:24.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:25:0)
[06:01:24.172] Timer tick, asking Buildbucket for the build status
[06:01:24.550] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:24.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:26:0) after 1m0s
[06:02:24.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:26:0)
[06:02:24.569] Timer tick, asking Buildbucket for the build status
[06:02:27.136] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:27.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:27:0) after 1m0s
[06:03:27.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:27:0)
[06:03:27.266] Timer tick, asking Buildbucket for the build status
[06:03:28.326] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:28.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:28:0) after 1m0s
[06:04:28.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:28:0)
[06:04:28.397] Timer tick, asking Buildbucket for the build status
[06:04:28.555] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:28.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:29:0) after 1m0s
[06:05:28.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:29:0)
[06:05:28.664] Timer tick, asking Buildbucket for the build status
[06:05:29.489] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:29.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:30:0) after 1m0s
[06:06:29.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:30:0)
[06:06:29.547] Timer tick, asking Buildbucket for the build status
[06:06:29.693] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:29.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:31:0) after 1m0s
[06:07:29.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:31:0)
[06:07:29.774] Timer tick, asking Buildbucket for the build status
[06:07:30.092] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:30.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:32:0) after 1m0s
[06:08:30.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:32:0)
[06:08:30.152] Timer tick, asking Buildbucket for the build status
[06:08:30.503] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:30.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:33:0) after 1m0s
[06:09:30.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:33:0)
[06:09:30.730] Timer tick, asking Buildbucket for the build status
[06:09:30.953] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:30.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:34:0) after 1m0s
[06:10:31.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:34:0)
[06:10:31.187] Timer tick, asking Buildbucket for the build status
[06:10:32.137] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:32.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:35:0) after 1m0s
[06:11:32.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:35:0)
[06:11:32.292] Timer tick, asking Buildbucket for the build status
[06:11:32.969] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:32.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:36:0) after 1m0s
[06:12:33.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:36:0)
[06:12:33.087] Timer tick, asking Buildbucket for the build status
[06:12:33.739] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:33.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:37:0) after 1m0s
[06:13:33.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:37:0)
[06:13:33.970] Timer tick, asking Buildbucket for the build status
[06:13:34.800] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:34.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:38:0) after 1m0s
[06:14:34.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:38:0)
[06:14:34.879] Timer tick, asking Buildbucket for the build status
[06:14:36.508] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:36.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:39:0) after 1m0s
[06:15:36.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:39:0)
[06:15:36.684] Timer tick, asking Buildbucket for the build status
[06:15:36.860] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:36.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:40:0) after 1m0s
[06:16:36.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:40:0)
[06:16:36.975] Timer tick, asking Buildbucket for the build status
[06:16:37.208] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:41:0) after 1m0s
[06:17:37.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:41:0)
[06:17:37.229] Timer tick, asking Buildbucket for the build status
[06:17:37.972] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:37.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:42:0) after 1m0s
[06:18:38.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:42:0)
[06:18:38.031] Timer tick, asking Buildbucket for the build status
[06:18:38.281] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:38.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:43:0) after 1m0s
[06:19:38.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:43:0)
[06:19:38.323] Timer tick, asking Buildbucket for the build status
[06:19:38.794] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:38.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:44:0) after 1m0s
[06:20:38.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:44:0)
[06:20:38.834] Timer tick, asking Buildbucket for the build status
[06:20:39.468] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:39.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:45:0) after 1m0s
[06:21:39.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:45:0)
[06:21:39.524] Timer tick, asking Buildbucket for the build status
[06:21:40.002] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:40.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:46:0) after 1m0s
[06:22:40.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:46:0)
[06:22:40.077] Timer tick, asking Buildbucket for the build status
[06:22:40.943] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:40.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:47:0) after 1m0s
[06:23:40.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:47:0)
[06:23:40.980] Timer tick, asking Buildbucket for the build status
[06:23:42.038] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:42.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:48:0) after 1m0s
[06:24:42.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:48:0)
[06:24:42.126] Timer tick, asking Buildbucket for the build status
[06:24:42.267] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:42.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:49:0) after 1m0s
[06:25:42.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:49:0)
[06:25:42.383] Timer tick, asking Buildbucket for the build status
[06:25:42.625] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:42.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:50:0) after 1m0s
[06:26:42.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:50:0)
[06:26:42.603] Timer tick, asking Buildbucket for the build status
[06:26:42.828] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:42.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:51:0) after 1m0s
[06:27:42.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:51:0)
[06:27:42.858] Timer tick, asking Buildbucket for the build status
[06:27:43.033] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:52:0) after 1m0s
[06:28:43.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:52:0)
[06:28:43.087] Timer tick, asking Buildbucket for the build status
[06:28:43.419] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:53:0) after 1m0s
[06:29:43.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:53:0)
[06:29:43.492] Timer tick, asking Buildbucket for the build status
[06:29:44.508] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:44.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:54:0) after 1m0s
[06:30:44.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:54:0)
[06:30:44.679] Timer tick, asking Buildbucket for the build status
[06:30:44.936] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:44.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:55:0) after 1m0s
[06:31:44.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:55:0)
[06:31:44.959] Timer tick, asking Buildbucket for the build status
[06:31:45.281] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:56:0) after 1m0s
[06:32:45.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:56:0)
[06:32:45.303] Timer tick, asking Buildbucket for the build status
[06:32:45.556] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:45.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:57:0) after 1m0s
[06:33:45.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:57:0)
[06:33:45.658] Timer tick, asking Buildbucket for the build status
[06:33:45.792] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:45.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:58:0) after 1m0s
[06:34:46.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:58:0)
[06:34:46.457] Timer tick, asking Buildbucket for the build status
[06:34:46.721] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:46.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:59:0) after 1m0s
[06:35:46.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:59:0)
[06:35:46.756] Timer tick, asking Buildbucket for the build status
[06:35:47.949] Build 8892400047142648256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:47.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057830109307777376:60:0) after 1m0s
[06:36:11.052] Received PubSub notification, asking Buildbucket for the build status
[06:36:11.254] Build 8892400047142648256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:36:11.254] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577946969653690",
"created_by": "project:chromium",
"created_ts": "1577943486038221",
"id": "8892400047142648256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5c5105c2eb2d73ae29444716ceae055ded53f5da\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-east1-d-8-73-pep6\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166844, \"got_angle_revision\": \"cbbfa2f28a0ee0ca652416d74b42c58238b24a3a\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"5c5105c2eb2d73ae29444716ceae055ded53f5da\", \"got_revision_cp\": \"refs/heads/master@{#727944}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"10a900e5ffaffdffe2806b1507af43a74acdfe9e\", \"got_v8_revision\": \"e7dd8e8dfc38217453b151faafe2088581b4542a\", \"got_v8_revision_cp\": \"refs/heads/8.1.81@{#1}\", \"got_webrtc_revision\": \"1c34ca7676e882100e29ef47258bfb2e41c30cbf\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30129}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5c5105c2eb2d73ae29444716ceae055ded53f5da\", \"swarm_hashes_refs/heads/master(at){#727944}_without_patch\": {\"accessibility_unittests\": \"2564b99ed0a637e1932762dc83a4473d538c9503\", \"angle_unittests\": \"651af4a828bf1e70b18433360e6c1697bd302003\", \"app_shell_unittests\": \"b5ebe8201c69ae47caf94a945e537b8224c79ce0\", \"aura_unittests\": \"1fd2927c77442a18ec75fb8c737bc40fe8d192f2\", \"base_unittests\": \"ad9b88fa9e92e893fc23eb54476744582c362491\", \"base_util_unittests\": \"24387c1fab42f1c630997865760d290bafae0b00\", \"blink_common_unittests\": \"cd9c068fe69b83f369a9385e7d0fcd0f546ad75f\", \"blink_fuzzer_unittests\": \"02c227eb3f43a026dbdd3132ef3105b1487b04fc\", \"blink_heap_unittests\": \"1efe89dadf5bcb4ee56a0ff9cbc3a22d3f342985\", \"blink_platform_unittests\": \"c58a15726009a2dbc2dc31921862d65b7939108b\", \"blink_python_tests\": \"c4ab56df4a117a3dcf8cfcb9243a26ab6fd91766\", \"blink_unittests\": \"993adb5d9d84ca900f5d7975f92ae9f93b48fed9\", \"blink_web_tests\": \"d53ef13fb3e652d273ca1a9bc8f2063e6df93b62\", \"boringssl_crypto_tests\": \"5b09f3f72503d660879c9b112d0d03ae8a57000a\", \"boringssl_ssl_tests\": \"adea84f9a1f69c6255cd4377dd879e2bbb3488b2\", \"browser_tests\": \"ce42e97fe6f7712eaf78561cb73219d8ad5c1cc2\", \"cacheinvalidation_unittests\": \"e4aefa25d6e815aa762deecbf185ff1c18567091\", \"capture_unittests\": \"c4725cfb41c81f3f0feaae04cc3bdf828660e2dc\", \"cast_unittests\": \"4396952ff226c933f09ec671a5e5b06b4c573de3\", \"cc_unittests\": \"480c6e7accfde290d29a8151f62e2e7700ea8d4f\", \"chrome_app_unittests\": \"a1b79a4dc4a70bff7cf874e318db425850a57bd6\", \"chromedriver_unittests\": \"7e67edd6266d02f350cda07a81c2a6ca6a0dd989\", \"components_browsertests\": \"5471acf690990abfbbb3a651915e33ae97291817\", \"components_unittests\": \"83a5c4417504c4b9e62cc105158af9c52347c185\", \"compositor_unittests\": \"17a5c18348691b0b96fba8ec623e8672c4cf8a04\", \"content_browsertests\": \"ae13e0ebcf2737a2d7c8ecc60822cde779c34435\", \"content_shell_crash_test\": \"ef4bee2ffbe5f721f15bac4d3331bc2ea70eefa3\", \"content_unittests\": \"71ca2f56b6cde296619cf4835dcd57e378fd6800\", \"crashpad_tests\": \"ced2b5096a9cf070175658f402457a761dbc0355\", \"cronet_tests\": \"043173e42db90c5c70bf74c5920cffae38617a22\", \"cronet_unittests\": \"37648059b38a2e83f5dfcd7a2299c963854b8d09\", \"crypto_unittests\": \"489b9939fd909395f44e1e6ecc6480735be70cfa\", \"dbus_unittests\": \"f138aa8ab1db400335d2f805d34a998124a843e2\", \"device_unittests\": \"604a33f378d459c1befa5440e66fd6e291bb71ae\", \"devtools_lint_check\": \"f8d29bf122a8878a796e78f5361295a01b244974\", \"devtools_type_check\": \"41a2684647e023acca4fd75576add11706776175\", \"display_unittests\": \"b69168f5c5e3d33e7f19ded73e0d6c206d86f753\", \"events_unittests\": \"8c1252a5d188e9ec9766d27e346122468afcc249\", \"extensions_browsertests\": \"b7e8f99076ad86f9030fb4f0015c20062ba70b5b\", \"extensions_unittests\": \"6f0dfd23d375fe00b446f3b62513014023c8abe7\", \"filesystem_service_unittests\": \"1b6fd2c53687f8efa9f9b7ccb362bfa52564c8eb\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"639e3f20194332cf146e75e6d41f1fc1f79d714c\", \"gfx_unittests\": \"612ad0a81bbe45db856e1ca02a6e6725bc895604\", \"gin_unittests\": \"7c5e9e645916b90eceadd7a4de1bf4409e531b61\", \"google_apis_unittests\": \"fe7941d21098e6ad2f4d1a67b1ce11b88c7796d3\", \"gpu_unittests\": \"dad1251ed73019b9c2cb52319f4b48d8f6161557\", \"grit_python_unittests\": \"c651860184eae0fccc98981c3c79be6f65eaf3fe\", \"gwp_asan_unittests\": \"e192982a5ef67d79183e2168378c395a8de83760\", \"headless_browsertests\": \"4fd5631cc421f70a5b91660378e68bae0beab51e\", \"headless_unittests\": \"8782077723544d1cbdef25377339d2d228f6af08\", \"interactive_ui_tests\": \"0bd2ebd751ea390b27aae6ca641de111fc4d6414\", \"ipc_tests\": \"fc5518a03b6ad32761942693794dc69d4bbe0878\", \"jingle_unittests\": \"08713380f8b486e5f682acdee9f5bd06c793750c\", \"latency_unittests\": \"0430eab9ab61b9c8c3f84ed83de8cff2b43f4bed\", \"libjingle_xmpp_unittests\": \"e1a7992bf263216510d2e91433ca172baae2e1a6\", \"media_blink_unittests\": \"ea7bd483c45031f520d038b1b596c8c36cc6d5c0\", \"media_service_unittests\": \"a6414ac6e7276625a82468da414fcdbfab9cad2e\", \"media_unittests\": \"121a458731478e6928341bb11dba0910d86d6bf4\", \"message_center_unittests\": \"a6ea083b0035099d3ab22c495202c4bc87d9e6dc\", \"metrics_python_tests\": \"d85db5c0e93dcf4f66a7cfe464526896fe229f60\", \"midi_unittests\": \"521031407f9d16dccc15c726add4fddb52a11d3a\", \"mojo_core_unittests\": \"e912be8b2338572f412cbec97b60b1e713b03af8\", \"mojo_unittests\": \"4902f472853285b0110adebd43227a331fb5580c\", \"nacl_helper_nonsfi_unittests\": \"0ab92f0146ce0c5adf34a610607e0de60a4b2683\", \"nacl_loader_unittests\": \"9eebd3af0c7a71ef00ca3696a99613ffb49f30be\", \"native_theme_unittests\": \"b0176463c1feba9e9b41ada91ba1e6c7826e54cc\", \"net_unittests\": \"8e3e1b234625457512382f2ab40e1a2d6c21e5dd\", \"pdf_unittests\": \"1b9a2f0808f5a7000c8347a4533533dc75febeff\", \"perfetto_unittests\": \"73867f6af7cedb3fb50bbf18b184f0cd3b72415b\", \"ppapi_unittests\": \"d4f9771b974d9e994f20452081865514f1dba0d0\", \"printing_unittests\": \"75c96938a3d464c234dd1755addefe802657f030\", \"remoting_unittests\": \"96fe9cee0f168ac85d45499b073c6ba3333e2a1d\", \"sandbox_linux_unittests\": \"064c891a350059a4ca8a609adef64df07e051ad0\", \"service_manager_unittests\": \"a0e0ddc66fca38fa707929f4d206cddf40569a66\", \"services_unittests\": \"7a9b813655f81375803e7278663cd449232673b3\", \"shell_dialogs_unittests\": \"82c69170619fa5e672d8873baf2c16c6e7245c1c\", \"skia_unittests\": \"a0062e11dc79122a6c04b88f7101a2ba6acd6313\", \"snapshot_unittests\": \"4fed14903dca75fb295ad296546bc3a93009f893\", \"sql_unittests\": \"711c6f6132d635285e32bc2c10f7d50119b839d8\", \"storage_unittests\": \"a80399ac885829ab60ef81baf34d65d2bed2603e\", \"sync_integration_tests\": \"8bac43ea46a7739dde108cee42df7a4fe91b66d9\", \"telemetry_gpu_unittests\": \"8c1cfed7cfd4754da36f31655114f0f389a0ae8a\", \"telemetry_perf_unittests\": \"51c207773e83514794ca765215da9c9ac94eba9c\", \"telemetry_unittests\": \"81bb47ad4dfdf26fb44df4dc446f46e6956e4469\", \"traffic_annotation_auditor_unittests\": \"1bf104b716e9ebf5c57d31e34d6081926b33552b\", \"ui_base_unittests\": \"0b9c44305b43b969f49308f50a75ddd2c5eb993c\", \"ui_touch_selection_unittests\": \"ecd9241adc8ed20a1e61d33b2378adefdaed4444\", \"unit_tests\": \"fd6e468a1266ad63cc577c47603adaac57788830\", \"url_unittests\": \"5a5396745deb84882253dd6d474e52f9a53b084b\", \"views_perftests\": \"ec97ea3a8e44380604e6eb58b723fd225e6c40d3\", \"views_unittests\": \"b758f654fc6a782841dc7fe0060588fe8811298d\", \"viz_unittests\": \"496f7e3e6d26ec1647e6de041325cae1e1e848e1\", \"vr_common_unittests\": \"743e2e4467610b2115a9a82d438bb8706164e674\", \"vr_pixeltests\": \"dfdd9f3020b31977757144b0c7550ae2b14b4ac3\", \"webdriver_wpt_tests\": \"6a43a28dc5b743b75ed86d90a0f41109f1f3da5d\", \"weblayer_browsertests\": \"0cbd73d094b1cbff90cec380d8418c8d45d17925\", \"wm_unittests\": \"5121110e081d20b13fe4fb532c6bff0ada2e1508\", \"wtf_unittests\": \"ae863d06012714e469279cd0932c19f6d2077cef\", \"xr_browser_tests\": \"d15dceb1401090e1abc7c851d88ff887f6cbcf92\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_016577e073ce9abf0fa10d80f88bc2caf8f81662b409bd6e59fa52089e44a3df_v2\", \"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_a7ee5da0df0016658701d083d0522e25adae25ba2fa23a313caa54097831117f_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-73-pep6\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577943782373155",
"status": "COMPLETED",
"status_changed_ts": "1577946970588601",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166844",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c5105c2eb2d73ae29444716ceae055ded53f5da",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057830109307777376",
"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/8892400047142648256/+/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:497d945967e46410",
"user_agent:luci-scheduler"
],
"updated_ts": "1577946970596119",
"url": "https://ci.chromium.org/b/8892400047142648256",
"utcnow_ts": "1577946971235323"
}
}
[06:36:11.254] Invocation finished in 58m6.664901087s with status SUCCEEDED