[02:09:30.277] New invocation is queued and will start shortly
[02:09:31.465] Starting the invocation (attempt 1)
[02:09:31.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:09:31.503] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:09:31.503] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053856965017743472",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d9520f05bfcfd0723f19ae07841ef0347f31ec00\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053856965017743472",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"gitiles_ref:refs/heads/master"
]
}
[02:09:32.934] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1581732571635525",
"id": "8888426902923312992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9520f05bfcfd0723f19ae07841ef0347f31ec00\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581732572499040",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168615",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053856965017743472",
"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/8888426902923312992/+/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": "1581732572499198",
"url": "https://ci.chromium.org/b/8888426902923312992",
"utcnow_ts": "1581732572923959"
}
}
[02:09:32.935] Task URL: https://ci.chromium.org/b/8888426902923312992
[02:09:32.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:2:0) after 1m0s
[02:10:33.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:2:0)
[02:10:33.073] Timer tick, asking Buildbucket for the build status
[02:10:33.200] Build 8888426902923312992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:33.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:3:0) after 1m0s
[02:11:33.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:3:0)
[02:11:33.352] Timer tick, asking Buildbucket for the build status
[02:11:33.473] Build 8888426902923312992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:33.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:4:0) after 1m0s
[02:12:33.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:4:0)
[02:12:33.561] Timer tick, asking Buildbucket for the build status
[02:12:34.011] Build 8888426902923312992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:34.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:5:0) after 1m0s
[02:13:34.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:5:0)
[02:13:34.071] Timer tick, asking Buildbucket for the build status
[02:13:34.984] Build 8888426902923312992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:34.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:6:0) after 1m0s
[02:14:10.585] Received PubSub notification, asking Buildbucket for the build status
[02:14:10.773] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:6:0)
[02:14:34.980] Timer tick, asking Buildbucket for the build status
[02:14:35.288] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:35.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:8:0) after 1m0s
[02:15:35.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:8:0)
[02:15:35.377] Timer tick, asking Buildbucket for the build status
[02:15:35.968] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:35.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:9:0) after 1m0s
[02:16:35.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:9:0)
[02:16:35.988] Timer tick, asking Buildbucket for the build status
[02:16:36.220] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:36.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:10:0) after 1m0s
[02:17:36.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:10:0)
[02:17:36.330] Timer tick, asking Buildbucket for the build status
[02:17:36.517] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:36.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:11:0) after 1m0s
[02:18:36.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:11:0)
[02:18:36.562] Timer tick, asking Buildbucket for the build status
[02:18:36.738] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:36.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:12:0) after 1m0s
[02:19:36.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:12:0)
[02:19:36.866] Timer tick, asking Buildbucket for the build status
[02:19:36.953] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:36.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:13:0) after 1m0s
[02:20:37.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:13:0)
[02:20:37.003] Timer tick, asking Buildbucket for the build status
[02:20:37.174] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:37.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:14:0) after 1m0s
[02:21:37.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:14:0)
[02:21:37.260] Timer tick, asking Buildbucket for the build status
[02:21:37.618] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:37.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:15:0) after 1m0s
[02:22:37.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:15:0)
[02:22:37.637] Timer tick, asking Buildbucket for the build status
[02:22:37.901] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:37.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:16:0) after 1m0s
[02:23:37.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:16:0)
[02:23:37.953] Timer tick, asking Buildbucket for the build status
[02:23:38.194] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:38.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:17:0) after 1m0s
[02:24:38.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:17:0)
[02:24:38.277] Timer tick, asking Buildbucket for the build status
[02:24:38.395] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:38.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:18:0) after 1m0s
[02:25:38.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:18:0)
[02:25:38.430] Timer tick, asking Buildbucket for the build status
[02:25:38.525] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:38.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:19:0) after 1m0s
[02:26:38.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:19:0)
[02:26:38.517] Timer tick, asking Buildbucket for the build status
[02:26:38.740] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:38.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:20:0) after 1m0s
[02:27:38.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:20:0)
[02:27:38.771] Timer tick, asking Buildbucket for the build status
[02:27:39.177] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:39.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:21:0) after 1m0s
[02:28:39.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:21:0)
[02:28:39.261] Timer tick, asking Buildbucket for the build status
[02:28:39.382] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:39.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:22:0) after 1m0s
[02:29:39.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:22:0)
[02:29:39.384] Timer tick, asking Buildbucket for the build status
[02:29:39.500] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:39.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:23:0) after 1m0s
[02:30:39.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:23:0)
[02:30:39.529] Timer tick, asking Buildbucket for the build status
[02:30:39.625] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:39.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:24:0) after 1m0s
[02:31:39.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:24:0)
[02:31:39.666] Timer tick, asking Buildbucket for the build status
[02:31:39.761] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:39.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:25:0) after 1m0s
[02:32:39.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:25:0)
[02:32:39.804] Timer tick, asking Buildbucket for the build status
[02:32:39.897] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:26:0) after 1m0s
[02:33:39.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:26:0)
[02:33:39.915] Timer tick, asking Buildbucket for the build status
[02:33:40.026] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:40.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:27:0) after 1m0s
[02:34:40.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:27:0)
[02:34:40.053] Timer tick, asking Buildbucket for the build status
[02:34:40.185] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:28:0) after 1m0s
[02:35:40.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:28:0)
[02:35:40.291] Timer tick, asking Buildbucket for the build status
[02:35:40.365] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:29:0) after 1m0s
[02:36:40.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:29:0)
[02:36:40.385] Timer tick, asking Buildbucket for the build status
[02:36:40.455] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:30:0) after 1m0s
[02:37:40.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:30:0)
[02:37:40.476] Timer tick, asking Buildbucket for the build status
[02:37:40.692] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:31:0) after 1m0s
[02:38:40.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:31:0)
[02:38:40.760] Timer tick, asking Buildbucket for the build status
[02:38:40.983] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:32:0) after 1m0s
[02:39:41.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:32:0)
[02:39:41.025] Timer tick, asking Buildbucket for the build status
[02:39:41.261] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:41.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:33:0) after 1m0s
[02:40:41.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:33:0)
[02:40:41.283] Timer tick, asking Buildbucket for the build status
[02:40:41.486] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:34:0) after 1m0s
[02:41:41.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:34:0)
[02:41:41.542] Timer tick, asking Buildbucket for the build status
[02:41:41.654] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:35:0) after 1m0s
[02:42:41.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:35:0)
[02:42:41.675] Timer tick, asking Buildbucket for the build status
[02:42:41.811] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:41.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:36:0) after 1m0s
[02:43:41.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:36:0)
[02:43:41.863] Timer tick, asking Buildbucket for the build status
[02:43:42.159] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:37:0) after 1m0s
[02:44:42.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:37:0)
[02:44:42.225] Timer tick, asking Buildbucket for the build status
[02:44:42.355] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:38:0) after 1m0s
[02:45:42.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:38:0)
[02:45:42.383] Timer tick, asking Buildbucket for the build status
[02:45:42.579] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:42.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:39:0) after 1m0s
[02:46:42.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:39:0)
[02:46:42.698] Timer tick, asking Buildbucket for the build status
[02:46:42.867] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:42.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:40:0) after 1m0s
[02:47:43.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:40:0)
[02:47:43.012] Timer tick, asking Buildbucket for the build status
[02:47:43.119] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:43.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:41:0) after 1m0s
[02:48:43.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:41:0)
[02:48:43.286] Timer tick, asking Buildbucket for the build status
[02:48:43.389] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:42:0) after 1m0s
[02:49:43.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:42:0)
[02:49:43.386] Timer tick, asking Buildbucket for the build status
[02:49:44.707] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:44.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:43:0) after 1m0s
[02:50:44.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:43:0)
[02:50:44.849] Timer tick, asking Buildbucket for the build status
[02:50:44.980] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:44.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:44:0) after 1m0s
[02:51:45.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:44:0)
[02:51:45.001] Timer tick, asking Buildbucket for the build status
[02:51:45.104] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:45.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:45:0) after 1m0s
[02:52:45.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:45:0)
[02:52:45.184] Timer tick, asking Buildbucket for the build status
[02:52:46.285] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:46.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:46:0) after 1m0s
[02:53:46.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:46:0)
[02:53:46.325] Timer tick, asking Buildbucket for the build status
[02:53:46.480] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:46.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:47:0) after 1m0s
[02:54:46.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:47:0)
[02:54:46.475] Timer tick, asking Buildbucket for the build status
[02:54:46.583] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:48:0) after 1m0s
[02:55:46.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:48:0)
[02:55:46.658] Timer tick, asking Buildbucket for the build status
[02:55:46.852] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:49:0) after 1m0s
[02:56:46.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:49:0)
[02:56:46.933] Timer tick, asking Buildbucket for the build status
[02:56:47.063] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:47.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:50:0) after 1m0s
[02:57:47.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:50:0)
[02:57:47.114] Timer tick, asking Buildbucket for the build status
[02:57:47.220] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:47.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:51:0) after 1m0s
[02:58:47.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:51:0)
[02:58:47.223] Timer tick, asking Buildbucket for the build status
[02:58:47.466] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:47.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:52:0) after 1m0s
[02:59:47.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:52:0)
[02:59:47.501] Timer tick, asking Buildbucket for the build status
[02:59:47.604] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:47.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:53:0) after 1m0s
[03:00:47.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:53:0)
[03:00:47.719] Timer tick, asking Buildbucket for the build status
[03:00:48.967] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:48.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:54:0) after 1m0s
[03:01:49.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:54:0)
[03:01:49.079] Timer tick, asking Buildbucket for the build status
[03:01:49.312] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:49.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:55:0) after 1m0s
[03:02:49.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:55:0)
[03:02:49.302] Timer tick, asking Buildbucket for the build status
[03:02:49.411] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:49.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:56:0) after 1m0s
[03:03:49.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:56:0)
[03:03:49.424] Timer tick, asking Buildbucket for the build status
[03:03:49.575] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:57:0) after 1m0s
[03:04:49.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:57:0)
[03:04:49.628] Timer tick, asking Buildbucket for the build status
[03:04:49.894] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:49.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:58:0) after 1m0s
[03:05:49.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:58:0)
[03:05:49.933] Timer tick, asking Buildbucket for the build status
[03:05:50.059] Build 8888426902923312992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:50.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053856965017743472:59:0) after 1m0s
[03:05:58.232] Received PubSub notification, asking Buildbucket for the build status
[03:05:58.772] Build 8888426902923312992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:05:58.772] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1581735957384221",
"created_by": "project:chromium",
"created_ts": "1581732571635525",
"id": "8888426902923312992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9520f05bfcfd0723f19ae07841ef0347f31ec00\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-82-qiah\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168615, \"got_angle_revision\": \"bb7534ee99ce9448b46be8975e916763ec6f0bf5\", \"got_dawn_revision\": \"71b3dd56da8d4e87c41d3e0a63342e593a8880c1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d9520f05bfcfd0723f19ae07841ef0347f31ec00\", \"got_revision_cp\": \"refs/heads/master@{#741699}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"348f07b40c2bb540b7fdc03765fe17f687ff91f5\", \"got_v8_revision\": \"ab92126379c635d62be6456c4599b5359b245015\", \"got_v8_revision_cp\": \"refs/heads/8.2.83@{#1}\", \"got_webrtc_revision\": \"08b11cafae02834dedb3230321c5f2c775febca2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30526}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9520f05bfcfd0723f19ae07841ef0347f31ec00\", \"swarm_hashes_refs/heads/master(at){#741699}_without_patch\": {\"accessibility_unittests\": \"7cda58ddeefbcc79bcdd6e3a7ef43daeb346664a\", \"angle_unittests\": \"ad05d4dc068a75afddaab2f54c31f5bee424f8e1\", \"app_shell_unittests\": \"48db3c6b70014cb20ba28cd24539f2454f586219\", \"aura_unittests\": \"b5a146ff5c26c044e16437d5544dc9c8910c3ba6\", \"base_unittests\": \"8eb1eb8ed9a765d7e089a49026a7408755c4c57f\", \"base_util_unittests\": \"247f2b6d2d1a520255b8a462ea858437da74837c\", \"blink_common_unittests\": \"e64c41fed0928133f7f4e213a495ea62be1ac07d\", \"blink_fuzzer_unittests\": \"6d3fca47a4067a1227fd66ac846c7d5181a8a1dd\", \"blink_heap_unittests\": \"e52f39e994576e0526056db5123d42f90ddded63\", \"blink_platform_unittests\": \"1075a7347c115279f87ab53adc66acc788f1c9da\", \"blink_python_tests\": \"fc9c936ef12f297cada07e3596f74c3f0650fe98\", \"blink_unittests\": \"ff90076e6456e3221febbdbd920ad59d2ec5337b\", \"blink_web_tests\": \"2d189aa1ce62326d44c2155e5e0e42cb73281ebf\", \"boringssl_crypto_tests\": \"9927cc1e99d1487b4ad37293c25e076ff7dfb475\", \"boringssl_ssl_tests\": \"ca8450965b384932401dd32fb1a196c1b8f2b90a\", \"browser_tests\": \"c0b030faa3835cb319a00fafa592c05ac0713df5\", \"cacheinvalidation_unittests\": \"615294346db7f37481d645ada108521ba69a3225\", \"capture_unittests\": \"b3b8883d4a40d77fb7f7054458a5dc1635e02df1\", \"cast_unittests\": \"984ee5074f02f339e1d32d7165ceac10ce8952ae\", \"cc_unittests\": \"cce5702ec59557f7c03d34b9056f38440b3ec8b3\", \"chrome_app_unittests\": \"ba327c5b7ce8c488e4e44f61860ae0415d4bb604\", \"chromedriver_unittests\": \"7ea7489df488c45826f86c9faa138260c255e1df\", \"components_browsertests\": \"db33bad8909bc2efeefae0d91905b7055454d21a\", \"components_unittests\": \"70898f793e7dbdb206f185b881bd687e9fcb596f\", \"compositor_unittests\": \"da6847264f08ee616fd3c421bf9fbe9f22bc7ee6\", \"content_browsertests\": \"7abfc41fa10c8003e6eb7a6ee8fd3c5bfb999d88\", \"content_shell_crash_test\": \"966c3221b01e045ff800b2ac279b265d631697f4\", \"content_unittests\": \"c957aa4822a02a4ac1dc67efbe275b8f43f84e81\", \"crashpad_tests\": \"74b7448adf864686aa5ad81e0e2497db9295d792\", \"cronet_tests\": \"eb48e63f1fbf681ec3845ed53795dc221b15e5b3\", \"cronet_unittests\": \"e505d5e5f7d00889e5b6ac57b245df1e13f2a82f\", \"crypto_unittests\": \"df8d2afb2c55ec3ac22f88365f9e38b2b1578b07\", \"dbus_unittests\": \"3bcdbd2351dd00b87692f6e6150f8bcb2cdbef74\", \"device_unittests\": \"7d8c382e85efa5ad2638e64be95f86ad564f76e1\", \"display_unittests\": \"c9df47d3359d73fca8c8c4c31094ce50f5ddac8f\", \"events_unittests\": \"322d7b433799d419c050034ba93b84bbfebd139c\", \"extensions_browsertests\": \"bd6ed3dd68373f9316570864424d585c2610258d\", \"extensions_unittests\": \"38fdc0048a10c1fb45cf717ef9bae3a28a7d84f5\", \"filesystem_service_unittests\": \"7c6be1308bd65cfdc9780e99b9c4e728b9aa4edb\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"afb808540c458202553c3637d5e41e62bf806264\", \"gfx_unittests\": \"aebcb51635b1297821a11b4f7adcabcc2fa9961a\", \"gin_unittests\": \"77ae1cf4985e28b6844e3aad71bd94e2b7337cad\", \"google_apis_unittests\": \"25a5911074edff482ffd995a7e8813caf2f58bd9\", \"gpu_unittests\": \"6d9a7633b5abf67950feb1c2add455228a3eb30f\", \"grit_python_unittests\": \"314a136826c68f2b20f2d52ddf6f5e567311beb1\", \"gwp_asan_unittests\": \"124524fe994b7cf83203041ef7d85f9b2523d970\", \"headless_browsertests\": \"db9852f58ef3c0a7177542d946921e55126b3226\", \"headless_unittests\": \"64d209a9d95dd5a54c9f21529f933dd67537b84f\", \"interactive_ui_tests\": \"d1f977266b4c9717a091aac0430d0ae74ad2705f\", \"ipc_tests\": \"23cfa41ecf27e08064f47ee18fbfdce254fb931f\", \"jingle_unittests\": \"4760b5ab3ee0dbfbd030b7e4d2ebc092e094c961\", \"latency_unittests\": \"a30a0711c3292647cefa056bb8b2310db6e21901\", \"libjingle_xmpp_unittests\": \"d548ae016dec854d620ada57e917df0c5f3c8b46\", \"media_blink_unittests\": \"6aade63fc51f150ac1535fccd94148a751ae950d\", \"media_service_unittests\": \"37e59307b7e63d9fdf60bceacce05b949622571e\", \"media_unittests\": \"20422d1d0c2601bcfd5517ba53e79f0f6a1e6980\", \"message_center_unittests\": \"fe34d025770e258187ede65f417b9fcedc978c2b\", \"metrics_python_tests\": \"a63ef32452cb35a3fed7c962db30aeb75959149d\", \"midi_unittests\": \"ca7280a46c5515618e0f3a20a216b0e998dc6177\", \"mojo_core_unittests\": \"5555951f1e9cc8037fb4c89c2acaba5eadcc3994\", \"mojo_unittests\": \"6490bf845271832d19e8495b9775e8a1b52fc4fe\", \"nacl_helper_nonsfi_unittests\": \"780544e37262fae2e103f68611af5ed37b01fe39\", \"nacl_loader_unittests\": \"85794c5823d3a8590976c47536c2b853cf5dc3e2\", \"native_theme_unittests\": \"1a48496a682bc6111cb6417f46aab208b8521743\", \"net_unittests\": \"9c84c7ebc4c272b96990715a4774197b9c9df6b0\", \"pdf_unittests\": \"183b850ac0db6f9c8cc3a5c9737429444434f76c\", \"perfetto_unittests\": \"a707f0e2a15ea16ae8de794aba09c768447d3f40\", \"ppapi_unittests\": \"e4e57f8d22ba9830e17e93815076f17ad8f473df\", \"printing_unittests\": \"265284b5fb4f22837f187f0740cc0410d3769001\", \"remoting_unittests\": \"a88174c3145269ee9da3846db4674696b5cd1199\", \"sandbox_linux_unittests\": \"2f14b75e6fc90c0eaaff009c54bd8e45911915ad\", \"service_manager_unittests\": \"db3912755e9dcb4879650a57de996b35d8f54cd1\", \"services_unittests\": \"e82cf8a4bda8458568e9cef5df95b4d5dea93ac4\", \"shell_dialogs_unittests\": \"340f6775c25ea6adc28dfe40a50395516279c19d\", \"skia_unittests\": \"15d8e7b99cde17403a3cc86c88f1a9f4af6ffba4\", \"snapshot_unittests\": \"71eca876ae003d37d42e3cd043c60bfe71c6e5e4\", \"sql_unittests\": \"004333257e2f8309f6b70416273ba520965cfe8e\", \"storage_unittests\": \"180c86fb455bb0680a87b5514a3fd5fe87c74eef\", \"sync_integration_tests\": \"b5d30b44563ec99d13bca5bf4a3d43812997633a\", \"telemetry_gpu_unittests\": \"3ab5f8a3be45cd5ffde7e0504eb118a4a370abaa\", \"telemetry_perf_unittests\": \"d751c4ef18e0d5cd074271e0edf09f33f0c8af63\", \"telemetry_unittests\": \"32db8e319e853ee861b27ba8101d8c171801d3f8\", \"traffic_annotation_auditor_unittests\": \"4a97d93f399f3637f41143ffd0e8401d7126e9e7\", \"ui_base_unittests\": \"431efd76db6394ef98dc03310a88eec31767a89e\", \"ui_touch_selection_unittests\": \"90f89793079cfb49cb0c32ef121f12908c490a42\", \"unit_tests\": \"19af5417c2a46a892216b6b6bbec13c519efd387\", \"url_unittests\": \"7f5111e9144955c8422065e2bf8512c47e98219d\", \"views_perftests\": \"89997a07f6fba8fa42b3298b4fd7c1ee1de5b282\", \"views_unittests\": \"b81b6ce5a9ad9dd8ee79295415fe4d7ee2b5f098\", \"viz_unittests\": \"bd1b537122e1aafd41faea372ea71da7340422ca\", \"vr_common_unittests\": \"5abdcb29a56ff2848b31abb024634b70bbda71fc\", \"vr_pixeltests\": \"1e7bfff0e359f0582f7a9268853ce26f0cddab81\", \"webdriver_wpt_tests\": \"884a289a6063643ca0a740f348aeb6140b83e4a1\", \"weblayer_browsertests\": \"3f9e485d74bf96a57616083a24f9dc87045a2eb7\", \"wm_unittests\": \"f47313c0eb6b6bd62eda72e3b2ae7dd653e339a6\", \"wtf_unittests\": \"88d7bc3827636331ef1d12395e9691f4e6b78c2e\", \"xr_browser_tests\": \"85ca1a80b860f9b62ea3f30064cf96ffef74c0c7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_43913798ffe4aacc9db317de63924a4a199b83672551513d069405cf6f3bc584_v2\", \"builder_497278b5819f10111ab639898a894ad19d361b24d185228ca986cf767de7a7ef_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_9ccb21220795a1d1972030c6b5d9b4569472a28790e1458f6676edb8e4495e8f_v2\", \"builder_eb75bb97ad9a82e6e51bc242be3605b13562b7c1ffaba99d94159b9b70e03009_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-82-qiah\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581732849868211",
"status": "COMPLETED",
"status_changed_ts": "1581735957794132",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168615",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9520f05bfcfd0723f19ae07841ef0347f31ec00",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053856965017743472",
"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/8888426902923312992/+/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:4a5f6d376c166d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581735957801886",
"url": "https://ci.chromium.org/b/8888426902923312992",
"utcnow_ts": "1581735958762021"
}
}
[03:05:58.772] Invocation finished in 56m28.518282124s with status SUCCEEDED