[09:53:28.819] New invocation is queued and will start shortly
[09:53:29.904] Starting the invocation (attempt 1)
[09:53:29.944] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:53:29.944] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:53:29.944] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050022701598808208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050022701598808208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"gitiles_ref:refs/heads/master"
]
}
[09:53:31.046] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585389210395734",
"id": "8884592639278652496",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585389210883902",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170302",
"builder:Linux Builder (dbg)",
"buildset:commit/git/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050022701598808208",
"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/8884592639278652496/+/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": "1585389210884037",
"url": "https://ci.chromium.org/b/8884592639278652496",
"utcnow_ts": "1585389211037856"
}
}
[09:53:31.046] Task URL: https://ci.chromium.org/b/8884592639278652496
[09:53:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:2:0) after 1m0s
[09:54:31.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:2:0)
[09:54:31.067] Timer tick, asking Buildbucket for the build status
[09:54:31.202] Build 8884592639278652496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:3:0) after 1m0s
[09:55:31.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:3:0)
[09:55:31.275] Timer tick, asking Buildbucket for the build status
[09:55:31.420] Build 8884592639278652496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:31.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:4:0) after 1m0s
[09:56:31.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:4:0)
[09:56:31.438] Timer tick, asking Buildbucket for the build status
[09:56:31.546] Build 8884592639278652496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:31.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:5:0) after 1m0s
[09:57:31.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:5:0)
[09:57:31.591] Timer tick, asking Buildbucket for the build status
[09:57:31.894] Build 8884592639278652496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:31.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:6:0) after 1m0s
[09:58:07.728] Received PubSub notification, asking Buildbucket for the build status
[09:58:07.839] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:31.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:6:0)
[09:58:31.921] Timer tick, asking Buildbucket for the build status
[09:58:32.501] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:32.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:8:0) after 1m0s
[09:59:32.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:8:0)
[09:59:32.580] Timer tick, asking Buildbucket for the build status
[09:59:32.804] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:32.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:9:0) after 1m0s
[10:00:32.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:9:0)
[10:00:32.874] Timer tick, asking Buildbucket for the build status
[10:00:33.012] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:33.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:10:0) after 1m0s
[10:01:33.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:10:0)
[10:01:33.101] Timer tick, asking Buildbucket for the build status
[10:01:33.277] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:33.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:11:0) after 1m0s
[10:02:33.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:11:0)
[10:02:33.359] Timer tick, asking Buildbucket for the build status
[10:02:33.527] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:33.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:12:0) after 1m0s
[10:03:33.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:12:0)
[10:03:33.673] Timer tick, asking Buildbucket for the build status
[10:03:34.072] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:34.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:13:0) after 1m0s
[10:04:34.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:13:0)
[10:04:34.125] Timer tick, asking Buildbucket for the build status
[10:04:34.370] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:34.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:14:0) after 1m0s
[10:05:34.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:14:0)
[10:05:34.419] Timer tick, asking Buildbucket for the build status
[10:05:34.617] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:34.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:15:0) after 1m0s
[10:06:34.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:15:0)
[10:06:34.691] Timer tick, asking Buildbucket for the build status
[10:06:34.940] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:34.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:16:0) after 1m0s
[10:07:34.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:16:0)
[10:07:34.961] Timer tick, asking Buildbucket for the build status
[10:07:35.092] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:35.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:17:0) after 1m0s
[10:08:35.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:17:0)
[10:08:35.148] Timer tick, asking Buildbucket for the build status
[10:08:38.266] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:38.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:18:0) after 1m0s
[10:09:38.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:18:0)
[10:09:38.372] Timer tick, asking Buildbucket for the build status
[10:09:38.475] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:38.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:19:0) after 1m0s
[10:10:38.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:19:0)
[10:10:38.548] Timer tick, asking Buildbucket for the build status
[10:10:38.760] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:38.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:20:0) after 1m0s
[10:11:38.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:20:0)
[10:11:38.785] Timer tick, asking Buildbucket for the build status
[10:11:39.127] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:39.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:21:0) after 1m0s
[10:12:39.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:21:0)
[10:12:39.201] Timer tick, asking Buildbucket for the build status
[10:12:39.384] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:39.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:22:0) after 1m0s
[10:13:39.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:22:0)
[10:13:39.425] Timer tick, asking Buildbucket for the build status
[10:13:40.460] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:40.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:23:0) after 1m0s
[10:14:40.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:23:0)
[10:14:40.518] Timer tick, asking Buildbucket for the build status
[10:14:40.676] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:40.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:24:0) after 1m0s
[10:15:40.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:24:0)
[10:15:40.699] Timer tick, asking Buildbucket for the build status
[10:15:40.855] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:40.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:25:0) after 1m0s
[10:16:40.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:25:0)
[10:16:40.906] Timer tick, asking Buildbucket for the build status
[10:16:41.043] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:41.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:26:0) after 1m0s
[10:17:41.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:26:0)
[10:17:41.065] Timer tick, asking Buildbucket for the build status
[10:17:41.224] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:41.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:27:0) after 1m0s
[10:18:41.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:27:0)
[10:18:41.244] Timer tick, asking Buildbucket for the build status
[10:18:42.130] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:42.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:28:0) after 1m0s
[10:19:42.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:28:0)
[10:19:42.171] Timer tick, asking Buildbucket for the build status
[10:19:42.385] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:42.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:29:0) after 1m0s
[10:20:42.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:29:0)
[10:20:42.545] Timer tick, asking Buildbucket for the build status
[10:20:42.714] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:42.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:30:0) after 1m0s
[10:21:42.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:30:0)
[10:21:42.737] Timer tick, asking Buildbucket for the build status
[10:21:42.896] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:42.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:31:0) after 1m0s
[10:22:43.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:31:0)
[10:22:43.029] Timer tick, asking Buildbucket for the build status
[10:22:43.335] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:43.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:32:0) after 1m0s
[10:23:43.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:32:0)
[10:23:43.424] Timer tick, asking Buildbucket for the build status
[10:23:43.636] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:33:0) after 1m0s
[10:24:43.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:33:0)
[10:24:43.674] Timer tick, asking Buildbucket for the build status
[10:24:43.791] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:34:0) after 1m0s
[10:25:44.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:34:0)
[10:25:44.005] Timer tick, asking Buildbucket for the build status
[10:25:44.286] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:35:0) after 1m0s
[10:26:44.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:35:0)
[10:26:44.307] Timer tick, asking Buildbucket for the build status
[10:26:44.454] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:44.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:36:0) after 1m0s
[10:27:44.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:36:0)
[10:27:44.493] Timer tick, asking Buildbucket for the build status
[10:27:44.617] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:37:0) after 1m0s
[10:28:44.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:37:0)
[10:28:44.651] Timer tick, asking Buildbucket for the build status
[10:28:45.129] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:45.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:38:0) after 1m0s
[10:29:45.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:38:0)
[10:29:45.369] Timer tick, asking Buildbucket for the build status
[10:29:45.594] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:39:0) after 1m0s
[10:30:45.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:39:0)
[10:30:45.711] Timer tick, asking Buildbucket for the build status
[10:30:45.814] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:45.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:40:0) after 1m0s
[10:31:45.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:40:0)
[10:31:45.912] Timer tick, asking Buildbucket for the build status
[10:31:45.997] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:45.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:41:0) after 1m0s
[10:32:46.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:41:0)
[10:32:46.061] Timer tick, asking Buildbucket for the build status
[10:32:46.221] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:46.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:42:0) after 1m0s
[10:33:46.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:42:0)
[10:33:46.261] Timer tick, asking Buildbucket for the build status
[10:33:46.602] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:46.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:43:0) after 1m0s
[10:34:46.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:43:0)
[10:34:46.666] Timer tick, asking Buildbucket for the build status
[10:34:46.984] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:46.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:44:0) after 1m0s
[10:35:47.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:44:0)
[10:35:47.013] Timer tick, asking Buildbucket for the build status
[10:35:47.261] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:47.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:45:0) after 1m0s
[10:36:47.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:45:0)
[10:36:47.387] Timer tick, asking Buildbucket for the build status
[10:36:47.565] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:47.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:46:0) after 1m0s
[10:37:47.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:46:0)
[10:37:47.652] Timer tick, asking Buildbucket for the build status
[10:37:47.763] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:47.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:47:0) after 1m0s
[10:38:47.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:47:0)
[10:38:47.838] Timer tick, asking Buildbucket for the build status
[10:38:48.095] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:48:0) after 1m0s
[10:39:48.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:48:0)
[10:39:48.173] Timer tick, asking Buildbucket for the build status
[10:39:48.371] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:48.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:49:0) after 1m0s
[10:40:48.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:49:0)
[10:40:48.408] Timer tick, asking Buildbucket for the build status
[10:40:48.877] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:48.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:50:0) after 1m0s
[10:41:49.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:50:0)
[10:41:49.021] Timer tick, asking Buildbucket for the build status
[10:41:49.160] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:49.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:51:0) after 1m0s
[10:42:49.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:51:0)
[10:42:49.192] Timer tick, asking Buildbucket for the build status
[10:42:49.319] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:49.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:52:0) after 1m0s
[10:43:49.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:52:0)
[10:43:49.343] Timer tick, asking Buildbucket for the build status
[10:43:49.451] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:49.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:53:0) after 1m0s
[10:44:49.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:53:0)
[10:44:49.640] Timer tick, asking Buildbucket for the build status
[10:44:49.749] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:49.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:54:0) after 1m0s
[10:45:49.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:54:0)
[10:45:49.806] Timer tick, asking Buildbucket for the build status
[10:45:49.916] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:49.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:55:0) after 1m0s
[10:46:49.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:55:0)
[10:46:49.900] Timer tick, asking Buildbucket for the build status
[10:46:50.002] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:50.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:56:0) after 1m0s
[10:47:50.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:56:0)
[10:47:50.035] Timer tick, asking Buildbucket for the build status
[10:47:50.319] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:50.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:57:0) after 1m0s
[10:48:50.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:57:0)
[10:48:50.397] Timer tick, asking Buildbucket for the build status
[10:48:50.849] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:50.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:58:0) after 1m0s
[10:49:50.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:58:0)
[10:49:50.917] Timer tick, asking Buildbucket for the build status
[10:49:51.164] Build 8884592639278652496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:51.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050022701598808208:59:0) after 1m0s
[10:50:39.375] Received PubSub notification, asking Buildbucket for the build status
[10:50:39.677] Build 8884592639278652496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:50:39.677] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585392638703510",
"created_by": "project:chromium",
"created_ts": "1585389210395734",
"id": "8884592639278652496",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$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-81-ujdt\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170302, \"got_angle_revision\": \"b387ce9389ede6a4ed3b831ab1b8187927fa295f\", \"got_dawn_revision\": \"81431f5034b4ce3a0cdc339709bd8ca8856fe427\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0\", \"got_revision_cp\": \"refs/heads/master@{#754298}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"de3f38a72c486c14a5cfe0810af9871acb7dec9a\", \"got_v8_revision\": \"bd43e20c8c22650fdcb84bf3e6e4543da293d07b\", \"got_v8_revision_cp\": \"refs/heads/8.3.100@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0\", \"swarm_hashes_refs/heads/master(at){#754298}_without_patch\": {\"accessibility_unittests\": \"51a3a50c11850230539e271f2cc95a69577091a4\", \"angle_unittests\": \"00c760068926b183d6aafb08b7d489c9698791dc\", \"app_shell_unittests\": \"0b0f8ff3c7c497a0f58c54020f96f611cc1b2165\", \"aura_unittests\": \"c9fd6e4ee90e759fb9937abdb6127b4a63d02f7b\", \"base_unittests\": \"d5e5bfc5aaaf43131d7e5bfb221ee5117d1e2189\", \"base_util_unittests\": \"11ca7e3d49437cdfdcb955c29868611e68341c1d\", \"blink_common_unittests\": \"6a5f57acb1fc8708eb3d0071dd9238952971f092\", \"blink_fuzzer_unittests\": \"708daf1e18e71b6114d46655444358647020fb57\", \"blink_heap_unittests\": \"fa48721eb932f5d2b767438711e16844edbbedc2\", \"blink_platform_unittests\": \"2d54ac734cb2309406cf95d3c0b6d294c49784d3\", \"blink_python_tests\": \"2589878e24dee9fbd70113c2ebc262f54a814e80\", \"blink_unittests\": \"0d79acd42281aa7173f9cb1cf0fe55c85c8696fc\", \"blink_web_tests\": \"230d1920a25a4f42aa43360757bf0a1c2df07793\", \"boringssl_crypto_tests\": \"e8e09b9f00ab8cc00963fc373de2eafeb34ccb9d\", \"boringssl_ssl_tests\": \"d89c67ef59569381a3e683818fdaea25b5cd3db3\", \"browser_tests\": \"7470b727cb37109c620d1a29f25b4d0320c98c54\", \"cacheinvalidation_unittests\": \"f44ea7dbec6b36533fa1eccf8f19e75e875de074\", \"capture_unittests\": \"cfde30c0966c6943639728a0b4c5433a1fdd307d\", \"cast_unittests\": \"38f07ce831c399881a80fb161f141cce582a831a\", \"cc_unittests\": \"a53a9203696d3523aa941bfe7eedb6028cd98925\", \"chrome_app_unittests\": \"f839783391093a39fd81179f138da2666a133c93\", \"chromedriver_unittests\": \"6c43c796c65f544c0819f4511b1e853120b931e4\", \"components_browsertests\": \"4bd331f10e1d0f086cce2afb8583bbcfdc8538b6\", \"components_unittests\": \"7a3386a4482d35458772ef8e4c25c925ff190ffc\", \"compositor_unittests\": \"4a24c598d373167ce6c5b39272824835f2743fd7\", \"content_browsertests\": \"be8410fc111f9bfbfdf549214f113bb87419ecb6\", \"content_shell_crash_test\": \"c8be60133251ae7415331465ca3e5faa915dd1ce\", \"content_unittests\": \"abe7ab984c54b26fd4dbfb5e6f038763fc86dcd2\", \"crashpad_tests\": \"a5cdcd6c71f83ed091fe450085f91aed7546b757\", \"cronet_tests\": \"7955219f1620911cbdf49028b793b21ba0b65347\", \"cronet_unittests\": \"89689a5e9ebfabd51a8457581da4f20709a6e2ff\", \"crypto_unittests\": \"2df85ac50516cef6c6f828157e9bc9972be9c5fd\", \"dbus_unittests\": \"7d34f96d0f6b889d3de407710090aa5f61b05f09\", \"device_unittests\": \"2d4c2ecedb64350acb18db648b6895b5de7d5e94\", \"display_unittests\": \"66b789d7fb9177a85c49377b219e447196bac908\", \"events_unittests\": \"e9ed3bf140c1debb769086890860da232f30bf45\", \"extensions_browsertests\": \"5730378226f2b605f71a3a429b2c3b10ef7208a3\", \"extensions_unittests\": \"5f101893cc604bda67a53267aba9189b6bb391cb\", \"filesystem_service_unittests\": \"e21199e0e5ab35e71ab7666f2e2c7baf0c3622a5\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"0b2e46c923d0da7afd6052de0ed115c682dc3652\", \"gfx_unittests\": \"6e638165746c9d9813c598ee253eec675b643992\", \"gin_unittests\": \"e38928a530da5819d3c41402e19514d27b823508\", \"google_apis_unittests\": \"06e3f073ba7139a6b13987350c316acbb46da929\", \"gpu_unittests\": \"469df8f774237f564be5076e6c2000e3e81db612\", \"grit_python_unittests\": \"4b6762478187600b0d776425ac36aaa43e7b6bc1\", \"gwp_asan_unittests\": \"e2cb286d8fdc32101d0fac7df00663dea6cc38fe\", \"headless_browsertests\": \"fc4a1e591502c1cdea9a5f83ee7f33eef58e86a8\", \"headless_unittests\": \"3ad0d398bc84e04faaa3d2c2db47b6efc74d58db\", \"interactive_ui_tests\": \"efbb6dcfb3f2351d1a1fa45fe4491966f4a8d962\", \"ipc_tests\": \"afd8f266d5960e9ff9d53344647a8ac8a3702b10\", \"jingle_unittests\": \"02659bbd3b5b5cef652e8087d71be64cf5f92a25\", \"latency_unittests\": \"6ab9bada187957eb106adebebf5fc76920a0a215\", \"libjingle_xmpp_unittests\": \"ed7181b0edccf77ed545ea2f5905bfc61c67bac6\", \"media_blink_unittests\": \"868caf6fcfea47737fe3969bedbefdfad6c44208\", \"media_unittests\": \"fd0e9aa25ff8cfd4da53a6599f9dcf16b5445ca4\", \"message_center_unittests\": \"3473b18923ccf29c1d1420ce25d39a8b6520140a\", \"metrics_python_tests\": \"c75734497ce169a9fa43cf7d5320a6c5f239e11a\", \"midi_unittests\": \"6aad2b90d48007c4e2372007705840ca8bca6d58\", \"mojo_core_unittests\": \"7530e9c6f29b6f87851079ec6c05d7a29c40aaf7\", \"mojo_unittests\": \"10eea5c5f8e844a0a0129ea8c9c712e5d8bd1639\", \"nacl_helper_nonsfi_unittests\": \"dea35ff9e2723e143e9130360833f64ab82a7061\", \"nacl_loader_unittests\": \"59321750591b219fba1df7bf7cee08f3aa94bfce\", \"native_theme_unittests\": \"df841d9529712a959d1366c303f91f02e8b41d2e\", \"net_unittests\": \"6d7ca87bca69940f2e258bfce82eba8dacf3806b\", \"pdf_unittests\": \"801a787a1d29142670aaee7c5eefbd6c6e66667b\", \"perfetto_unittests\": \"322a911fde851662b885ef140c566ce41c76b8c9\", \"ppapi_unittests\": \"fbf58890aa0ff231830bf5ac7b6607474e61c8f3\", \"printing_unittests\": \"d632166221c65c76b3c7187b7c7fd41e05a97943\", \"remoting_unittests\": \"485382a9d2c586ceafbaeb2baad7b5d4c4c33bb9\", \"sandbox_linux_unittests\": \"2a46841807b673394d78fb9a8c32ca6c73fb7af5\", \"service_manager_unittests\": \"655fac2ed6a5364d3e89ad4495829f97fbd1780a\", \"services_unittests\": \"b85f78aa5a8b513cc2727ba97440f6eb556e5ae5\", \"shell_dialogs_unittests\": \"c4c0fa5ca819b75ea02dc7cf23a9f019e4e9f18d\", \"skia_unittests\": \"b6d67316990786eb3064fa67577a174e45895f4d\", \"snapshot_unittests\": \"552260592b234dbe77f459c48d3dd79cf0fef60b\", \"sql_unittests\": \"0773b1c479d7982c5519f1127ec5ea70b4cf03fe\", \"storage_unittests\": \"386d359ce6b37d20d07be8ad256e7c9d5b2368df\", \"sync_integration_tests\": \"e2e368616951e5118bf4ba9fbcd1dd20088c279e\", \"telemetry_gpu_unittests\": \"55cfd0b9cbd8fbc6edd9740273ec28c3c3f848c3\", \"telemetry_perf_unittests\": \"2f659f804a9756bfcaf41acbdf92bf2c39033f3b\", \"telemetry_unittests\": \"50ea11b0e9984fab9f87f2b88d0775565e4a3f0e\", \"traffic_annotation_auditor_unittests\": \"5184d7de74075a9e234feb009ce7ed88d37435ad\", \"ui_base_unittests\": \"e5aa23624102de643d5e0cb240d7610f797be09c\", \"ui_touch_selection_unittests\": \"651ffb2e5b7f9390b5aac4f77d114ab83ab0d9f2\", \"unit_tests\": \"51ec83e5ca559f92c3ec10fcfc13c6299d7e4637\", \"url_unittests\": \"38f4c474a34069f928bc9792302e6a4b03b9eb54\", \"views_perftests\": \"baa0e136a5137e5dc28db69206e92bfbd50ef843\", \"views_unittests\": \"555e626a2c1cc04b703efbd0598e9f960b963e47\", \"viz_unittests\": \"d6b8f737af4a2d647793bc8872810d03b3c8550e\", \"vr_common_unittests\": \"f936073af1ead7908a25edfcedb2b32b4d9c1834\", \"vr_pixeltests\": \"139e6cd9ece88f254ded7bc1881fab3b84447a3a\", \"webdriver_wpt_tests\": \"38cdddeef333a7ddb23468c6aaf338999ec851bd\", \"weblayer_browsertests\": \"564a1c15ddba39f1f4eb71d9b816b8eb74573929\", \"wm_unittests\": \"5eaac4b3cd82f91ba6a77c473dd64f9bfd066b5a\", \"wtf_unittests\": \"43d38df45710a2b1bea64b0683447c767819de90\", \"xr_browser_tests\": \"ec8e1b4afb0acfeb4c252356c8796da3e8083714\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-81-ujdt\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"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\": [\"4901-91f024a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585389486910290",
"status": "COMPLETED",
"status_changed_ts": "1585392638954346",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170302",
"builder:Linux Builder (dbg)",
"buildset:commit/git/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/399e5281ed9b9815b2bb5ae8f6800c9fbf26e9e0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050022701598808208",
"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/8884592639278652496/+/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:4b396115fc901c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585392638957598",
"url": "https://ci.chromium.org/b/8884592639278652496",
"utcnow_ts": "1585392639651547"
}
}
[10:50:39.677] Invocation finished in 57m10.878614488s with status SUCCEEDED