[12:08:28.647] New invocation is queued and will start shortly
[12:08:30.278] Starting the invocation (attempt 1)
[12:08:30.328] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:08:30.331] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:08:30.331] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054725250562257344",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"18bc87f05146a7ed37b71dceec87c6eb80b80aa4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054725250562257344",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"gitiles_ref:refs/heads/master"
]
}
[12:08:31.491] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1580904510859899",
"id": "8889295187580210224",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18bc87f05146a7ed37b71dceec87c6eb80b80aa4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580904511308181",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168256",
"builder:Linux Builder (dbg)",
"buildset:commit/git/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054725250562257344",
"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/8889295187580210224/+/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": "1580904511308323",
"url": "https://ci.chromium.org/b/8889295187580210224",
"utcnow_ts": "1580904511481992"
}
}
[12:08:31.491] Task URL: https://ci.chromium.org/b/8889295187580210224
[12:08:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:2:0) after 1m0s
[12:09:31.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:2:0)
[12:09:31.510] Timer tick, asking Buildbucket for the build status
[12:09:32.031] Build 8889295187580210224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:09:32.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:3:0) after 1m0s
[12:10:32.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:3:0)
[12:10:32.052] Timer tick, asking Buildbucket for the build status
[12:10:32.753] Build 8889295187580210224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:10:32.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:4:0) after 1m0s
[12:11:32.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:4:0)
[12:11:32.986] Timer tick, asking Buildbucket for the build status
[12:11:33.245] Build 8889295187580210224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:11:33.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:5:0) after 1m0s
[12:12:33.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:5:0)
[12:12:33.294] Timer tick, asking Buildbucket for the build status
[12:12:33.648] Build 8889295187580210224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:12:33.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:6:0) after 1m0s
[12:13:09.308] Received PubSub notification, asking Buildbucket for the build status
[12:13:09.438] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:33.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:6:0)
[12:13:33.700] Timer tick, asking Buildbucket for the build status
[12:13:34.261] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:34.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:8:0) after 1m0s
[12:14:34.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:8:0)
[12:14:34.324] Timer tick, asking Buildbucket for the build status
[12:14:34.521] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:9:0) after 1m0s
[12:15:34.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:9:0)
[12:15:34.579] Timer tick, asking Buildbucket for the build status
[12:15:35.365] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:35.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:10:0) after 1m0s
[12:16:35.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:10:0)
[12:16:35.383] Timer tick, asking Buildbucket for the build status
[12:16:35.577] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:35.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:11:0) after 1m0s
[12:17:35.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:11:0)
[12:17:35.598] Timer tick, asking Buildbucket for the build status
[12:17:36.048] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:36.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:12:0) after 1m0s
[12:18:36.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:12:0)
[12:18:36.062] Timer tick, asking Buildbucket for the build status
[12:18:36.368] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:36.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:13:0) after 1m0s
[12:19:36.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:13:0)
[12:19:36.395] Timer tick, asking Buildbucket for the build status
[12:19:36.573] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:36.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:14:0) after 1m0s
[12:20:36.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:14:0)
[12:20:36.591] Timer tick, asking Buildbucket for the build status
[12:20:36.885] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:36.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:15:0) after 1m0s
[12:21:36.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:15:0)
[12:21:36.913] Timer tick, asking Buildbucket for the build status
[12:21:37.069] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:16:0) after 1m0s
[12:22:37.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:16:0)
[12:22:37.097] Timer tick, asking Buildbucket for the build status
[12:22:37.340] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:37.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:17:0) after 1m0s
[12:23:37.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:17:0)
[12:23:37.421] Timer tick, asking Buildbucket for the build status
[12:23:37.826] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:37.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:18:0) after 1m0s
[12:24:37.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:18:0)
[12:24:37.903] Timer tick, asking Buildbucket for the build status
[12:24:38.475] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:38.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:19:0) after 1m0s
[12:25:38.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:19:0)
[12:25:38.529] Timer tick, asking Buildbucket for the build status
[12:25:38.809] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:38.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:20:0) after 1m0s
[12:26:38.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:20:0)
[12:26:38.782] Timer tick, asking Buildbucket for the build status
[12:26:38.956] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:38.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:21:0) after 1m0s
[12:27:38.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:21:0)
[12:27:38.977] Timer tick, asking Buildbucket for the build status
[12:27:39.122] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:39.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:22:0) after 1m0s
[12:28:39.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:22:0)
[12:28:39.207] Timer tick, asking Buildbucket for the build status
[12:28:39.371] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:39.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:23:0) after 1m0s
[12:29:39.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:23:0)
[12:29:39.391] Timer tick, asking Buildbucket for the build status
[12:29:39.615] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:39.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:24:0) after 1m0s
[12:30:39.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:24:0)
[12:30:39.791] Timer tick, asking Buildbucket for the build status
[12:30:39.980] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:25:0) after 1m0s
[12:31:39.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:25:0)
[12:31:39.959] Timer tick, asking Buildbucket for the build status
[12:31:40.197] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:40.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:26:0) after 1m0s
[12:32:40.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:26:0)
[12:32:40.267] Timer tick, asking Buildbucket for the build status
[12:32:40.484] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:40.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:27:0) after 1m0s
[12:33:40.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:27:0)
[12:33:40.505] Timer tick, asking Buildbucket for the build status
[12:33:40.998] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:40.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:28:0) after 1m0s
[12:34:41.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:28:0)
[12:34:41.101] Timer tick, asking Buildbucket for the build status
[12:34:41.855] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:41.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:29:0) after 1m0s
[12:35:41.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:29:0)
[12:35:41.875] Timer tick, asking Buildbucket for the build status
[12:35:42.094] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:42.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:30:0) after 1m0s
[12:36:42.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:30:0)
[12:36:42.108] Timer tick, asking Buildbucket for the build status
[12:36:42.332] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:42.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:31:0) after 1m0s
[12:37:42.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:31:0)
[12:37:42.356] Timer tick, asking Buildbucket for the build status
[12:37:42.568] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:42.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:32:0) after 1m0s
[12:38:42.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:32:0)
[12:38:42.599] Timer tick, asking Buildbucket for the build status
[12:38:43.536] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:43.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:33:0) after 1m0s
[12:39:43.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:33:0)
[12:39:43.619] Timer tick, asking Buildbucket for the build status
[12:39:44.795] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:44.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:34:0) after 1m0s
[12:40:44.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:34:0)
[12:40:44.838] Timer tick, asking Buildbucket for the build status
[12:40:45.022] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:35:0) after 1m0s
[12:41:45.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:35:0)
[12:41:45.062] Timer tick, asking Buildbucket for the build status
[12:41:45.476] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:45.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:36:0) after 1m0s
[12:42:45.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:36:0)
[12:42:45.539] Timer tick, asking Buildbucket for the build status
[12:42:46.049] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:46.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:37:0) after 1m0s
[12:43:46.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:37:0)
[12:43:46.073] Timer tick, asking Buildbucket for the build status
[12:43:46.413] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:46.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:38:0) after 1m0s
[12:44:46.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:38:0)
[12:44:46.520] Timer tick, asking Buildbucket for the build status
[12:44:46.751] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:46.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:39:0) after 1m0s
[12:45:46.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:39:0)
[12:45:46.847] Timer tick, asking Buildbucket for the build status
[12:45:47.010] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:47.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:40:0) after 1m0s
[12:46:47.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:40:0)
[12:46:47.046] Timer tick, asking Buildbucket for the build status
[12:46:47.457] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:41:0) after 1m0s
[12:47:47.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:41:0)
[12:47:47.645] Timer tick, asking Buildbucket for the build status
[12:47:47.979] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:47.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:42:0) after 1m0s
[12:48:47.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:42:0)
[12:48:47.986] Timer tick, asking Buildbucket for the build status
[12:48:48.200] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:48.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:43:0) after 1m0s
[12:49:48.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:43:0)
[12:49:48.284] Timer tick, asking Buildbucket for the build status
[12:49:48.514] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:48.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:44:0) after 1m0s
[12:50:48.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:44:0)
[12:50:48.677] Timer tick, asking Buildbucket for the build status
[12:50:48.937] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:48.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:45:0) after 1m0s
[12:51:48.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:45:0)
[12:51:48.952] Timer tick, asking Buildbucket for the build status
[12:51:49.349] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:49.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:46:0) after 1m0s
[12:52:49.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:46:0)
[12:52:49.381] Timer tick, asking Buildbucket for the build status
[12:52:49.825] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:49.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:47:0) after 1m0s
[12:53:49.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:47:0)
[12:53:49.953] Timer tick, asking Buildbucket for the build status
[12:53:52.852] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:52.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:48:0) after 1m0s
[12:54:52.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:48:0)
[12:54:52.969] Timer tick, asking Buildbucket for the build status
[12:54:53.568] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:53.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:49:0) after 1m0s
[12:55:53.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:49:0)
[12:55:53.596] Timer tick, asking Buildbucket for the build status
[12:55:54.585] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:54.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:50:0) after 1m0s
[12:56:54.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:50:0)
[12:56:54.605] Timer tick, asking Buildbucket for the build status
[12:56:55.194] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:55.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:51:0) after 1m0s
[12:57:55.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:51:0)
[12:57:55.215] Timer tick, asking Buildbucket for the build status
[12:57:55.357] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:55.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:52:0) after 1m0s
[12:58:55.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:52:0)
[12:58:55.376] Timer tick, asking Buildbucket for the build status
[12:58:55.562] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:55.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:53:0) after 1m0s
[12:59:55.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:53:0)
[12:59:55.597] Timer tick, asking Buildbucket for the build status
[12:59:55.803] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:55.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:54:0) after 1m0s
[13:00:55.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:54:0)
[13:00:55.843] Timer tick, asking Buildbucket for the build status
[13:00:56.269] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:56.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:55:0) after 1m0s
[13:01:56.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:55:0)
[13:01:56.333] Timer tick, asking Buildbucket for the build status
[13:01:56.485] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:56.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:56:0) after 1m0s
[13:02:56.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:56:0)
[13:02:56.561] Timer tick, asking Buildbucket for the build status
[13:02:56.736] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:56.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:57:0) after 1m0s
[13:03:56.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:57:0)
[13:03:56.831] Timer tick, asking Buildbucket for the build status
[13:03:56.984] Build 8889295187580210224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:56.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054725250562257344:58:0) after 1m0s
[13:04:01.704] Received PubSub notification, asking Buildbucket for the build status
[13:04:02.873] Build 8889295187580210224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:04:02.873] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1580907840196848",
"created_by": "project:chromium",
"created_ts": "1580904510859899",
"id": "8889295187580210224",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18bc87f05146a7ed37b71dceec87c6eb80b80aa4\"}}",
"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-68-q8mh\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168256, \"got_angle_revision\": \"ec816af6e720e254aa8cca441fa4e2fa9c4d100a\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"18bc87f05146a7ed37b71dceec87c6eb80b80aa4\", \"got_revision_cp\": \"refs/heads/master@{#738527}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8e8e1d0dd7292440b803b95bc0832589520f784d\", \"got_v8_revision\": \"30fcb3ebe01452448273e5fe198141107973b5fd\", \"got_v8_revision_cp\": \"refs/heads/8.2.11@{#1}\", \"got_webrtc_revision\": \"0f6bcd18b2ef109850c6430fa0d474688571da5f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30455}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18bc87f05146a7ed37b71dceec87c6eb80b80aa4\", \"swarm_hashes_refs/heads/master(at){#738527}_without_patch\": {\"accessibility_unittests\": \"1786b9e7245228d1ab8c88e7cdb9c01c6bd4d2fc\", \"angle_unittests\": \"59a03e296d4aebf8c606508c8b0915964ae782c0\", \"app_shell_unittests\": \"66e4cab15775f9575feb6b98b45443f227447b6c\", \"aura_unittests\": \"87ad60e3eb2d22df0b40ab69eb421d664c5b29ae\", \"base_unittests\": \"3bfc59e4a9bfee28436a1564c03362335e2b33c0\", \"base_util_unittests\": \"8818a9773a30bd7c33cdec37a93518b2382f934c\", \"blink_common_unittests\": \"8d8c48effb158ef7b1efe068a2df3732d559859b\", \"blink_fuzzer_unittests\": \"4e04fc0ea8a22e2ab55a5337b1e760db53245ee5\", \"blink_heap_unittests\": \"0fb15ad63ed06e3a2117e40eb9e85bc159bcc9de\", \"blink_platform_unittests\": \"54d515152b1af1c1da4e4b33493709c896db1363\", \"blink_python_tests\": \"428d782e3af1d82e4005e8fb3921ffcfe5d6a5cf\", \"blink_unittests\": \"a65953c78208a3ee90d4bc6d83ba089b65661363\", \"blink_web_tests\": \"cd0b62feb840f1e94d7585fceead093b40d0534a\", \"boringssl_crypto_tests\": \"647acdbbf37dcb1c568c903868bcd7d855eb8d3d\", \"boringssl_ssl_tests\": \"2d20c1e4e0accd9c244ab60965347348f2ba0707\", \"browser_tests\": \"cdc6a7f6d4bb3f1751053e0e510bda6f88df1543\", \"cacheinvalidation_unittests\": \"fb78258f28fc3710799ce5f9fc563eff7a407fe6\", \"capture_unittests\": \"94e1c59ce8d5ec02d2c378cb83081e38cac4a755\", \"cast_unittests\": \"e843dd5f45df5a6bbafc78d0a2d7912302a08def\", \"cc_unittests\": \"e546779c9340c698c4d1bc40c5feeea9c1e95fc9\", \"chrome_app_unittests\": \"6a46baab478965d6eb5848b995451a4ec83342de\", \"chromedriver_unittests\": \"cd20c4b95f5d798ce52fa6472f8cbb3d93dca6ac\", \"components_browsertests\": \"49041a41c4e3269bed84340514a2ec195e3ccab6\", \"components_unittests\": \"f4b4d1399559df68b81e9576a401722f54d0a6f6\", \"compositor_unittests\": \"4b35b16025109faa5b2c0be4b821398954b10f89\", \"content_browsertests\": \"7c5a298f1b3231011d9ebe03a3a4a5a6eb5389ed\", \"content_shell_crash_test\": \"43bf0bacb23f06895687ce498386da2ef575b5f2\", \"content_unittests\": \"2cd347222a8e24c4bc7601568730e8dda4df5601\", \"crashpad_tests\": \"0af122a680e0eff26626a05740cfdd0e49ba9701\", \"cronet_tests\": \"7243fd68736c272290937f0618025249ccf335e9\", \"cronet_unittests\": \"1e05f5ef1f8b1a1c4bc4b1a5715b9c1672570be2\", \"crypto_unittests\": \"71311b088be815360ef6cc6ea5930edb34e2864b\", \"dbus_unittests\": \"873e817e19dbdc5f49bf65aaf57c76570748dbc7\", \"device_unittests\": \"775970b06e9f40482858ef262446c2f447ed6bf9\", \"display_unittests\": \"aefadf9c92c934ee1963a2d03ddd2cd516452571\", \"events_unittests\": \"813576e726abe6a6ff1b0121b9bc9f7770ff156a\", \"extensions_browsertests\": \"ed0fb538b0b8a8d2f02aa711f5a02efe38a84eff\", \"extensions_unittests\": \"a5bdda5c0fcd4156a41af08097b9324962d06a57\", \"filesystem_service_unittests\": \"1a2b869b7c50c54220c88837f04505704757b5d1\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"db8bc81205fac4b6556f128af6086844cc9552cf\", \"gfx_unittests\": \"dc138b0f77bb5e94a6adaf5ee53f77e8d99500da\", \"gin_unittests\": \"fa69ee668a204048b037ee1b394dbec47e2ee492\", \"google_apis_unittests\": \"77d751ee6fa99399a43021aeea3c4580bb1f5c55\", \"gpu_unittests\": \"119cbe3a5e603ec998f0f265f6264a9b61bed848\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"d2d57150bbed91c14f6cd4b17df0b9b078449849\", \"headless_browsertests\": \"eedf064433994131cd9c733cea21cd92164c950f\", \"headless_unittests\": \"cd4593e24bb54ddfc3a51c2d93c61e9decc68961\", \"interactive_ui_tests\": \"05047881e545b3afc0b3c60ba913b498ff243164\", \"ipc_tests\": \"d74c98ce51b5c43dd0d28c93c777df0c8a8f01f4\", \"jingle_unittests\": \"608ae36a0ea6ab48d8a2de5dd24c8d309ab9b8c7\", \"latency_unittests\": \"6be33fb23e6767b216fd655922a6fd4459f7d09c\", \"libjingle_xmpp_unittests\": \"30e8f4801d30ee5339e5d67549d426f26b9b7e6b\", \"media_blink_unittests\": \"159eb3191aa83ae51c3096b4412d69c27dd8fc36\", \"media_service_unittests\": \"05713fe1684287628389981b7a7514c7dfcd4dcc\", \"media_unittests\": \"ad0a80b3f991f63a096205238822e2ca4071e5c5\", \"message_center_unittests\": \"0aae52ce025f392de6c9f45b804fbddc90612f17\", \"metrics_python_tests\": \"013f5c8016160cc35cde9e11cee400bc4ba11477\", \"midi_unittests\": \"dd9fc8c0530a150cc97eff2763a3e6aa65fc459a\", \"mojo_core_unittests\": \"cea2055bc973787f0b09972f913f38b422a730ee\", \"mojo_unittests\": \"255ba2aca04a1e8653f33f1a6e3c75d232242146\", \"nacl_helper_nonsfi_unittests\": \"45f7057fb6cc6d43c9d425196d4f8b8e3c47ec86\", \"nacl_loader_unittests\": \"6099b256c6f2efb129fc9b504703e59d67ecea1b\", \"native_theme_unittests\": \"0eff071275e53736ed6bc28d184868dd88b58713\", \"net_unittests\": \"714a54f311d7e7e17ab4de24f52c2160ca903e12\", \"pdf_unittests\": \"f02f5afb36ba08badd62afd4139377a7173e7043\", \"perfetto_unittests\": \"d51745a03ec3b8b79894238a7ed287bf7e2adc66\", \"ppapi_unittests\": \"c0ec6d85848d8dfdf7db6f2f34dbd9c37337bf26\", \"printing_unittests\": \"ff8e182ac60182d8bd21db7abc412603581d17dc\", \"remoting_unittests\": \"80f33b361c7c4d5904a7fc8d3479a4c8b06fd115\", \"sandbox_linux_unittests\": \"f077ad62754d18572a2ee9ce2d3d872a65c6e5a6\", \"service_manager_unittests\": \"69cc813a592b8e120384eb6ed2feb37fdfbbadf1\", \"services_unittests\": \"58a960e9c3c1ed282a81024f43f32d86050232d0\", \"shell_dialogs_unittests\": \"a56afcbb7a5ec9114a795de4e82426ad9f48e1a7\", \"skia_unittests\": \"855291b36dc282f3a650de17c770a7467a21ef42\", \"snapshot_unittests\": \"d668fc8839e4d0378c27a96fc7a569a4a1b89889\", \"sql_unittests\": \"a3b4ee81735b81745ef66d3f2cdb4792e51234d2\", \"storage_unittests\": \"05459ecabbfdb77d2b69b5752c4c0c35539e798f\", \"sync_integration_tests\": \"030047622a8ef25e46ee2925daa72407e562fa18\", \"telemetry_gpu_unittests\": \"f9deb5ea419bbcd0375ba2e418a1698928b2e0db\", \"telemetry_perf_unittests\": \"8f773425738b61894c93ee442071e53118fb4f5f\", \"telemetry_unittests\": \"dd26ec3fd3a11efd5ce8611be91338f78f13177c\", \"traffic_annotation_auditor_unittests\": \"a64efba7506677f55710f63ccb9d10a260be97de\", \"ui_base_unittests\": \"f36229042a92b02adaa4d06d6f484f8fdcf6d6e2\", \"ui_touch_selection_unittests\": \"a0952d5460f2def859772d78d93696e2a0adb369\", \"unit_tests\": \"67781788d8abe776dab16b33a48ed5fa060ca6bc\", \"url_unittests\": \"b8eaf0836e6db239d6632a693484058f3e084ff3\", \"views_perftests\": \"3642eb272a0c71fd567bc9ba8d19cdeea9c9b62c\", \"views_unittests\": \"b9c66637679746dfb1a764768908e283eda7418a\", \"viz_unittests\": \"1a3abc57ec15a3214e33f4261074be31463da950\", \"vr_common_unittests\": \"adbd053d5e35349ccda0390cda990ea9219c9b1b\", \"vr_pixeltests\": \"c547b5c89358843bb0cf1926190fbb2a935e22b7\", \"webdriver_wpt_tests\": \"00a937803dcf039367d8604d1807d417adb8ed89\", \"weblayer_browsertests\": \"ab7a93c8825a0471af2de445c3a31a4c823261cd\", \"wm_unittests\": \"68098202d9ad5c279e8f7ad7da82c80cac1b0ff7\", \"wtf_unittests\": \"43966aecb6ac23de51aa7ef81baea7b6920562de\", \"xr_browser_tests\": \"548dac8fb6835976076e7c803d7b4f4afc57540b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0095fe006eafdabf54002a791fb8c836a288874203ece8347c24b74b8d090ce3_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-68-q8mh\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580904787415360",
"status": "COMPLETED",
"status_changed_ts": "1580907840760984",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168256",
"builder:Linux Builder (dbg)",
"buildset:commit/git/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18bc87f05146a7ed37b71dceec87c6eb80b80aa4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054725250562257344",
"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/8889295187580210224/+/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:4a2e1200e2498c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1580907840858644",
"url": "https://ci.chromium.org/b/8889295187580210224",
"utcnow_ts": "1580907842063799"
}
}
[13:04:02.873] Invocation finished in 55m34.242296158s with status SUCCEEDED