[02:45:16.855] New invocation is queued and will start shortly
[02:45:18.307] Starting the invocation (attempt 1)
[02:45:18.345] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:45:18.345] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:45:18.345] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054670086863921280",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f44a870b8137465e1baae16d743d600d89f28bf9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054670086863921280",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f44a870b8137465e1baae16d743d600d89f28bf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f44a870b8137465e1baae16d743d600d89f28bf9",
"gitiles_ref:refs/heads/master"
]
}
[02:45:19.012] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580957118503411",
"id": "8889240024466480128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f44a870b8137465e1baae16d743d600d89f28bf9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580957118839884",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168279",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f44a870b8137465e1baae16d743d600d89f28bf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f44a870b8137465e1baae16d743d600d89f28bf9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054670086863921280",
"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/8889240024466480128/+/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": "1580957118840033",
"url": "https://ci.chromium.org/b/8889240024466480128",
"utcnow_ts": "1580957119005424"
}
}
[02:45:19.012] Task URL: https://ci.chromium.org/b/8889240024466480128
[02:45:19.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:2:0) after 1m0s
[02:46:19.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:2:0)
[02:46:19.155] Timer tick, asking Buildbucket for the build status
[02:46:19.348] Build 8889240024466480128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:19.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:3:0) after 1m0s
[02:47:19.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:3:0)
[02:47:19.737] Timer tick, asking Buildbucket for the build status
[02:47:20.532] Build 8889240024466480128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:20.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:4:0) after 1m0s
[02:48:20.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:4:0)
[02:48:20.699] Timer tick, asking Buildbucket for the build status
[02:48:20.859] Build 8889240024466480128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:20.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:5:0) after 1m0s
[02:49:20.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:5:0)
[02:49:20.986] Timer tick, asking Buildbucket for the build status
[02:49:21.990] Build 8889240024466480128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:21.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:6:0) after 1m0s
[02:50:17.346] Received PubSub notification, asking Buildbucket for the build status
[02:50:17.509] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:22.394] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:6:0)
[02:50:22.394] Timer tick, asking Buildbucket for the build status
[02:50:22.538] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:22.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:8:0) after 1m0s
[02:51:22.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:8:0)
[02:51:22.574] Timer tick, asking Buildbucket for the build status
[02:51:22.789] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:22.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:9:0) after 1m0s
[02:52:22.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:9:0)
[02:52:22.850] Timer tick, asking Buildbucket for the build status
[02:52:23.008] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:23.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:10:0) after 1m0s
[02:53:23.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:10:0)
[02:53:23.067] Timer tick, asking Buildbucket for the build status
[02:53:23.233] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:23.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:11:0) after 1m0s
[02:54:23.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:11:0)
[02:54:23.270] Timer tick, asking Buildbucket for the build status
[02:54:23.427] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:23.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:12:0) after 1m0s
[02:55:23.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:12:0)
[02:55:23.606] Timer tick, asking Buildbucket for the build status
[02:55:23.873] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:23.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:13:0) after 1m0s
[02:56:24.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:13:0)
[02:56:24.016] Timer tick, asking Buildbucket for the build status
[02:56:24.165] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:24.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:14:0) after 1m0s
[02:57:24.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:14:0)
[02:57:24.192] Timer tick, asking Buildbucket for the build status
[02:57:24.369] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:24.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:15:0) after 1m0s
[02:58:24.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:15:0)
[02:58:24.349] Timer tick, asking Buildbucket for the build status
[02:58:24.501] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:24.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:16:0) after 1m0s
[02:59:24.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:16:0)
[02:59:24.537] Timer tick, asking Buildbucket for the build status
[02:59:24.707] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:24.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:17:0) after 1m0s
[03:00:24.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:17:0)
[03:00:24.860] Timer tick, asking Buildbucket for the build status
[03:00:25.324] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:25.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:18:0) after 1m0s
[03:01:25.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:18:0)
[03:01:25.457] Timer tick, asking Buildbucket for the build status
[03:01:25.817] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:19:0) after 1m0s
[03:02:25.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:19:0)
[03:02:25.842] Timer tick, asking Buildbucket for the build status
[03:02:26.118] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:26.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:20:0) after 1m0s
[03:03:26.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:20:0)
[03:03:26.099] Timer tick, asking Buildbucket for the build status
[03:03:26.251] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:26.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:21:0) after 1m0s
[03:04:26.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:21:0)
[03:04:26.272] Timer tick, asking Buildbucket for the build status
[03:04:27.257] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:27.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:22:0) after 1m0s
[03:05:27.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:22:0)
[03:05:27.260] Timer tick, asking Buildbucket for the build status
[03:05:27.715] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:27.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:23:0) after 1m0s
[03:06:27.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:23:0)
[03:06:27.800] Timer tick, asking Buildbucket for the build status
[03:06:27.952] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:27.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:24:0) after 1m0s
[03:07:27.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:24:0)
[03:07:27.994] Timer tick, asking Buildbucket for the build status
[03:07:28.472] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:28.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:25:0) after 1m0s
[03:08:28.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:25:0)
[03:08:28.522] Timer tick, asking Buildbucket for the build status
[03:08:28.707] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:28.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:26:0) after 1m0s
[03:09:28.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:26:0)
[03:09:28.740] Timer tick, asking Buildbucket for the build status
[03:09:28.895] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:28.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:27:0) after 1m0s
[03:10:28.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:27:0)
[03:10:28.929] Timer tick, asking Buildbucket for the build status
[03:10:29.484] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:29.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:28:0) after 1m0s
[03:11:29.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:28:0)
[03:11:29.545] Timer tick, asking Buildbucket for the build status
[03:11:29.749] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:29.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:29:0) after 1m0s
[03:12:29.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:29:0)
[03:12:29.807] Timer tick, asking Buildbucket for the build status
[03:12:29.963] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:29.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:30:0) after 1m0s
[03:13:29.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:30:0)
[03:13:29.961] Timer tick, asking Buildbucket for the build status
[03:13:31.388] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:31.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:31:0) after 1m0s
[03:14:31.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:31:0)
[03:14:31.408] Timer tick, asking Buildbucket for the build status
[03:14:31.815] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:31.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:32:0) after 1m0s
[03:15:31.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:32:0)
[03:15:31.868] Timer tick, asking Buildbucket for the build status
[03:15:32.133] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:32.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:33:0) after 1m0s
[03:16:32.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:33:0)
[03:16:32.165] Timer tick, asking Buildbucket for the build status
[03:16:32.361] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:34:0) after 1m0s
[03:17:32.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:34:0)
[03:17:32.386] Timer tick, asking Buildbucket for the build status
[03:17:32.589] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:32.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:35:0) after 1m0s
[03:18:32.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:35:0)
[03:18:32.623] Timer tick, asking Buildbucket for the build status
[03:18:32.856] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:32.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:36:0) after 1m0s
[03:19:32.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:36:0)
[03:19:32.906] Timer tick, asking Buildbucket for the build status
[03:19:33.801] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:33.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:37:0) after 1m0s
[03:20:33.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:37:0)
[03:20:33.893] Timer tick, asking Buildbucket for the build status
[03:20:34.210] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:34.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:38:0) after 1m0s
[03:21:34.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:38:0)
[03:21:34.304] Timer tick, asking Buildbucket for the build status
[03:21:34.456] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:34.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:39:0) after 1m0s
[03:22:34.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:39:0)
[03:22:34.582] Timer tick, asking Buildbucket for the build status
[03:22:35.268] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:35.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:40:0) after 1m0s
[03:23:35.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:40:0)
[03:23:35.423] Timer tick, asking Buildbucket for the build status
[03:23:35.604] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:35.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:41:0) after 1m0s
[03:24:35.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:41:0)
[03:24:35.783] Timer tick, asking Buildbucket for the build status
[03:24:35.942] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:35.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:42:0) after 1m0s
[03:25:36.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:42:0)
[03:25:36.036] Timer tick, asking Buildbucket for the build status
[03:25:36.259] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:36.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:43:0) after 1m0s
[03:26:36.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:43:0)
[03:26:36.376] Timer tick, asking Buildbucket for the build status
[03:26:36.553] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:36.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:44:0) after 1m0s
[03:27:36.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:44:0)
[03:27:36.607] Timer tick, asking Buildbucket for the build status
[03:27:36.973] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:36.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:45:0) after 1m0s
[03:28:37.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:45:0)
[03:28:37.055] Timer tick, asking Buildbucket for the build status
[03:28:37.204] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:37.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:46:0) after 1m0s
[03:29:37.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:46:0)
[03:29:37.315] Timer tick, asking Buildbucket for the build status
[03:29:37.453] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:37.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:47:0) after 1m0s
[03:30:37.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:47:0)
[03:30:37.506] Timer tick, asking Buildbucket for the build status
[03:30:37.673] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:37.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:48:0) after 1m0s
[03:31:37.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:48:0)
[03:31:37.726] Timer tick, asking Buildbucket for the build status
[03:31:38.390] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:38.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:49:0) after 1m0s
[03:32:38.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:49:0)
[03:32:38.503] Timer tick, asking Buildbucket for the build status
[03:32:39.154] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:39.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:50:0) after 1m0s
[03:33:39.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:50:0)
[03:33:39.265] Timer tick, asking Buildbucket for the build status
[03:33:39.413] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:39.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:51:0) after 1m0s
[03:34:39.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:51:0)
[03:34:39.529] Timer tick, asking Buildbucket for the build status
[03:34:39.666] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:39.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:52:0) after 1m0s
[03:35:39.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:52:0)
[03:35:39.663] Timer tick, asking Buildbucket for the build status
[03:35:39.878] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:39.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:53:0) after 1m0s
[03:36:40.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:53:0)
[03:36:40.065] Timer tick, asking Buildbucket for the build status
[03:36:40.263] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:54:0) after 1m0s
[03:37:40.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:54:0)
[03:37:40.238] Timer tick, asking Buildbucket for the build status
[03:37:40.399] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:40.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:55:0) after 1m0s
[03:38:40.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:55:0)
[03:38:40.558] Timer tick, asking Buildbucket for the build status
[03:38:41.063] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:41.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:56:0) after 1m0s
[03:39:41.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:56:0)
[03:39:41.156] Timer tick, asking Buildbucket for the build status
[03:39:41.663] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:57:0) after 1m0s
[03:40:41.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:57:0)
[03:40:41.682] Timer tick, asking Buildbucket for the build status
[03:40:41.855] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:41.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:58:0) after 1m0s
[03:41:41.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:58:0)
[03:41:41.867] Timer tick, asking Buildbucket for the build status
[03:41:42.148] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:42.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:59:0) after 1m0s
[03:42:42.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:59:0)
[03:42:42.265] Timer tick, asking Buildbucket for the build status
[03:42:42.571] Build 8889240024466480128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:42.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054670086863921280:60:0) after 1m0s
[03:43:24.129] Received PubSub notification, asking Buildbucket for the build status
[03:43:26.603] Build 8889240024466480128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:43:26.603] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580960602992816",
"created_by": "project:chromium",
"created_ts": "1580957118503411",
"id": "8889240024466480128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f44a870b8137465e1baae16d743d600d89f28bf9\"}}",
"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-east1-d-8-6-m56b\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168279, \"got_angle_revision\": \"20b1259ae94e522a48ff43bd05f75b82b8fa9703\", \"got_dawn_revision\": \"7fe6efba4ae3388b0cc858b95b4e3755191fc942\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f44a870b8137465e1baae16d743d600d89f28bf9\", \"got_revision_cp\": \"refs/heads/master@{#738807}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"dd48b7e2d06e74e1d20da5f43224b4ae99873e64\", \"got_v8_revision\": \"d2d1b4e48e988a3bff798f5d815e678c3057bb05\", \"got_v8_revision_cp\": \"refs/heads/8.2.15@{#1}\", \"got_webrtc_revision\": \"703a5d76d9ba8e7984509cc7bf70fb4ed84ef6be\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30461}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f44a870b8137465e1baae16d743d600d89f28bf9\", \"swarm_hashes_refs/heads/master(at){#738807}_without_patch\": {\"accessibility_unittests\": \"b110504b69855b827a5e411d22b729271597fdcc\", \"angle_unittests\": \"a6c3119f53d190248c01b41e60df9d0baacba94f\", \"app_shell_unittests\": \"eae8e6a319e46aea5b4b8c88dfe186c00e02e057\", \"aura_unittests\": \"d92ef31b6c3d68617fcb0095871b639ac01f8a00\", \"base_unittests\": \"30ef8037a643620edb4cbd53e63d99597d529c1a\", \"base_util_unittests\": \"1fb24bf247e4c9ff5abdd7750c9e5d4ba74014d0\", \"blink_common_unittests\": \"205d515f8c7cb556bb46fc103bcceafc07caae56\", \"blink_fuzzer_unittests\": \"d9f0bce75480ff56892899321b52d7839267527b\", \"blink_heap_unittests\": \"ff66d282cf04bf578fa3f53b01a9c2f79695d889\", \"blink_platform_unittests\": \"33a7d4928b09c979ad4517cdea69cfac2623e2e2\", \"blink_python_tests\": \"ab68f28bb8f8a88ac25d3cd36b90a67a54bac2b1\", \"blink_unittests\": \"c08272d78cdc14f111f0e88ceee1b8b100cf5949\", \"blink_web_tests\": \"31ef65bf17b22c746c514accda0fa6c759969077\", \"boringssl_crypto_tests\": \"59ffb3dea1f049cbd1273457caef906771add2ec\", \"boringssl_ssl_tests\": \"9d93285a4117d25760a190a2546ea756631a04f4\", \"browser_tests\": \"c0e620ee0f21b162cdae5bde13d5d6ba963f5ab0\", \"cacheinvalidation_unittests\": \"6380104f37c3571d0d5b29db58ed9a95e25d4918\", \"capture_unittests\": \"107a69cf94aa430c8e0b796d4e75764a3e008dc7\", \"cast_unittests\": \"a99fa67cd28eda067471dc1c50f640d6ecb925a4\", \"cc_unittests\": \"ed8569525ff113588286eabe70519dc7296cfaa8\", \"chrome_app_unittests\": \"f7eaa5dbd889ec17eaff741b37f1ceec02b6238a\", \"chromedriver_unittests\": \"a09b0b470efdf556d00808556c0ecc21e410f560\", \"components_browsertests\": \"52ac3878d66d7d7de2b8e4baf8206c770b093081\", \"components_unittests\": \"44c3470fe91d3de7c370a74179715d9acf24240a\", \"compositor_unittests\": \"57c7cfb22a65e3b47fb1c6cc64a396277f55ba3c\", \"content_browsertests\": \"4ecc2c142ce4d8429a60fe510ae58458349f8a7e\", \"content_shell_crash_test\": \"7d0652e7b12ab2638606c673b03cb8f82aa17e68\", \"content_unittests\": \"bb07b81807a90a64807c1e3f8cf37930461871d0\", \"crashpad_tests\": \"97dca390746ab8567b9524558b89a33e0117cc59\", \"cronet_tests\": \"fee917f8bc722c76f176dddd0a08f8c50baf783a\", \"cronet_unittests\": \"c47e78f25179a69522785741364e6266ee3b54c4\", \"crypto_unittests\": \"11dde5e8a63f1a3f08858116887b4741e24d9071\", \"dbus_unittests\": \"9ca9077bb30479a16583f3ad19e7871f79bd83b8\", \"device_unittests\": \"44b8d59d91f7497740279509f0f8bda8f15a0bf3\", \"display_unittests\": \"1b8981e792307c91d9d0789b9ae2092d2f03c27b\", \"events_unittests\": \"94dccf7e4defdefe33a9c35a37da62841d604967\", \"extensions_browsertests\": \"56b9c6cafaeba6eeca7c85ed911e20dc791cb382\", \"extensions_unittests\": \"62a54613b69d2f098345cbdb56feb8882512e77b\", \"filesystem_service_unittests\": \"0b01fcc33be9dc424593c044c839c7f7662da738\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"085a33a2c47370553edf28831c4bad30f026d68c\", \"gfx_unittests\": \"71902ac11e74c783d651c581a5375febe8e18a11\", \"gin_unittests\": \"8c10cdd3f6ca433a872e128c5fd71def809ccc0e\", \"google_apis_unittests\": \"fca60b2127a676e1dc7dd1ef8c91af2d15f87c00\", \"gpu_unittests\": \"9a017e8bf246dcdb60e36b1dd306a2e85ce224f8\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"8fc6d56be132770b2ee265dbeddb3b544a9642a0\", \"headless_browsertests\": \"1b6c400c9f8552c10bfd341de995d9dd8b8098d5\", \"headless_unittests\": \"25e0d8b9f9281480482ac7b3bbd9194714a72524\", \"interactive_ui_tests\": \"c86fd8dfb912c9fdeb2af6a01f8d76a17bbbd112\", \"ipc_tests\": \"5dcd2a9028d4c558e52cdd0490fde05ad9015584\", \"jingle_unittests\": \"6aa12a1afe76378e460a26cabaeabfca4d54a70b\", \"latency_unittests\": \"679cddfbe0a8f69edd4a6b8f83b6d42db92d5818\", \"libjingle_xmpp_unittests\": \"1b598cc6aad73d036269cc36898bf53bf7d4890b\", \"media_blink_unittests\": \"1758f56b465ef08bc8df38e4bdda298cdf48cde5\", \"media_service_unittests\": \"371e9ca4680257d147164b5064515b9fb812ee2b\", \"media_unittests\": \"365ac64767d6611e96e56c4c57ddd7a9d5d0b002\", \"message_center_unittests\": \"2f02750dd65bce2ae002904345d5c15f4a6baad6\", \"metrics_python_tests\": \"997d5f5a83b412d280a942b809d66d164a47b42d\", \"midi_unittests\": \"0300237b144968e57853e02fe1cda46eec29617f\", \"mojo_core_unittests\": \"df61682da07ad1c046f0577d98fec4c0f422bc18\", \"mojo_unittests\": \"d7a677a4c10fb163ebcd7b0c93a11d3aa593a6f9\", \"nacl_helper_nonsfi_unittests\": \"53cd259b7b1e63cfce3b0db5e6fbd19310b9abc2\", \"nacl_loader_unittests\": \"8383d80e83b0d752bc3825a8e360b3a10d8b806d\", \"native_theme_unittests\": \"7b4e6feed0d3a1448dc393037b0a1a0dd3621834\", \"net_unittests\": \"1a8bd5d2e2c8b975a5060fd84182e9497bff42ef\", \"pdf_unittests\": \"2e42c0961b390d669d2375b66bad48edd68e819c\", \"perfetto_unittests\": \"977903dd56561d1d863119e8fe34709a9264e30b\", \"ppapi_unittests\": \"4670ffb98d3231efbda0370f8a8013d307d63dde\", \"printing_unittests\": \"5447b7944d141d996ffb24cf686ef5d3886f9b76\", \"remoting_unittests\": \"0d4c85a395f86aad3746d7638895a12673f3cdbe\", \"sandbox_linux_unittests\": \"8fd52c5d27e8e0be6081b7efa31224dae8cb44f6\", \"service_manager_unittests\": \"d97c79858a32e7aa0b75c3db37367f7d991b8f4c\", \"services_unittests\": \"ec01d652203ac682d96feaa2179db9339748f0ed\", \"shell_dialogs_unittests\": \"c69894c89f7c9435496a306ac84c5428efbffd75\", \"skia_unittests\": \"ba88828368dc757038a91437d844034ecdf79a31\", \"snapshot_unittests\": \"bb1ad3f555826c1fa7d233f1932885552a9a5928\", \"sql_unittests\": \"e0b85af04651f692556bb86f3d7c34732b893b77\", \"storage_unittests\": \"72abc5835276505c9c29e69278e839b5c09dd680\", \"sync_integration_tests\": \"4fa5ee89a6d426c67fc2d0103486d04cffa32592\", \"telemetry_gpu_unittests\": \"3e49d196f771ff9c10f69585928c841599e26a79\", \"telemetry_perf_unittests\": \"3d11ca0506293cde788103cb7c758a08d54dcdf1\", \"telemetry_unittests\": \"9222e44b8a9820c88afbaaf058f9aba8354933f3\", \"traffic_annotation_auditor_unittests\": \"33fa11c76213c0b6c629d9a21a4555bae13eeca9\", \"ui_base_unittests\": \"7beddd026ab807c1d13be226e24e5218435081ac\", \"ui_touch_selection_unittests\": \"8986d0fd81060aaca214feace49489ba71df304b\", \"unit_tests\": \"6c7ba99fdce2d7f44da9be9fe0ac7fe38090f7ee\", \"url_unittests\": \"34652ba7cca8da879ad7ab10b09f204ed0a12188\", \"views_perftests\": \"c829ea216c984e33dd4289466c5e33a2e8fb5874\", \"views_unittests\": \"8327ca3ee9738b90bd6deac998c7979476451254\", \"viz_unittests\": \"56ece9497ad50e21d16fc6f3b4aff89ec743bc7e\", \"vr_common_unittests\": \"04b5a9b41434f49f16035f794cc79f9fcfe51d21\", \"vr_pixeltests\": \"ea29b7a0ca3147614ba33fd2869bd39c83763d73\", \"webdriver_wpt_tests\": \"db446ba8ee24d0b06bd47d8cb4ff03da8e5a295c\", \"weblayer_browsertests\": \"ae6bb83236b3125332d271a1f1014264e9edfa43\", \"wm_unittests\": \"ede3c23a032b977ab588b3a0b4faa73aaaf43e55\", \"wtf_unittests\": \"d17ce118e225ff0acc5f9028a6c3528ef9cb6f47\", \"xr_browser_tests\": \"47cd128011f8b1f0acacad6991c7ddea24c0ff24\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1c97ebbcfb2b59a51287991f2ed562e10321e4784ed0e8a7a3677e8f006ec0dd_v2\", \"builder_341c32bd45a59798b0d31a376a872da37ddfa394c44785a08305266670677548_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_a4e8234367f6e9970c36d6e793971f7a1ed9e2532234459a292e8560f005826d_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-east1-d-8-6-m56b\"], \"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\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580957416166204",
"status": "COMPLETED",
"status_changed_ts": "1580960603416500",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168279",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f44a870b8137465e1baae16d743d600d89f28bf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f44a870b8137465e1baae16d743d600d89f28bf9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054670086863921280",
"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/8889240024466480128/+/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:4a3134bcb602cb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1580960603420580",
"url": "https://ci.chromium.org/b/8889240024466480128",
"utcnow_ts": "1580960606593405"
}
}
[03:43:26.603] Invocation finished in 58m9.770094856s with status SUCCEEDED