[19:32:34.148] New invocation is queued and will start shortly
[19:32:35.373] Starting the invocation (attempt 1)
[19:32:35.452] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:32:35.456] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:32:35.456] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054244325899002352",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7ef8fcb1ae40589d4e1c700bfa4050f7343199fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054244325899002352",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"gitiles_ref:refs/heads/master"
]
}
[19:32:36.257] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581363155667264",
"id": "8888814263641511744",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ef8fcb1ae40589d4e1c700bfa4050f7343199fe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581363156109631",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168462",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054244325899002352",
"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/8888814263641511744/+/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": "1581363156109829",
"url": "https://ci.chromium.org/b/8888814263641511744",
"utcnow_ts": "1581363156248503"
}
}
[19:32:36.257] Task URL: https://ci.chromium.org/b/8888814263641511744
[19:32:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:2:0) after 1m0s
[19:33:36.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:2:0)
[19:33:36.384] Timer tick, asking Buildbucket for the build status
[19:33:36.519] Build 8888814263641511744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:36.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:3:0) after 1m0s
[19:34:36.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:3:0)
[19:34:36.657] Timer tick, asking Buildbucket for the build status
[19:34:36.989] Build 8888814263641511744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:36.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:4:0) after 1m0s
[19:35:37.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:4:0)
[19:35:37.077] Timer tick, asking Buildbucket for the build status
[19:35:37.233] Build 8888814263641511744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:37.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:5:0) after 1m0s
[19:36:37.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:5:0)
[19:36:37.402] Timer tick, asking Buildbucket for the build status
[19:36:37.524] Build 8888814263641511744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:37.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:6:0) after 1m0s
[19:37:37.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:6:0)
[19:37:37.663] Timer tick, asking Buildbucket for the build status
[19:37:37.831] Build 8888814263641511744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:37.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:7:0) after 1m0s
[19:37:46.514] Received PubSub notification, asking Buildbucket for the build status
[19:37:46.608] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:37.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:7:0)
[19:38:37.971] Timer tick, asking Buildbucket for the build status
[19:38:38.074] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:38.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:9:0) after 1m0s
[19:39:38.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:9:0)
[19:39:38.371] Timer tick, asking Buildbucket for the build status
[19:39:39.789] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:39.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:10:0) after 1m0s
[19:40:39.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:10:0)
[19:40:39.886] Timer tick, asking Buildbucket for the build status
[19:40:40.712] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:40.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:11:0) after 1m0s
[19:41:40.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:11:0)
[19:41:40.826] Timer tick, asking Buildbucket for the build status
[19:41:41.234] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:41.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:12:0) after 1m0s
[19:42:41.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:12:0)
[19:42:41.337] Timer tick, asking Buildbucket for the build status
[19:42:41.792] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:13:0) after 1m0s
[19:43:41.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:13:0)
[19:43:41.820] Timer tick, asking Buildbucket for the build status
[19:43:42.840] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:14:0) after 1m0s
[19:44:42.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:14:0)
[19:44:42.860] Timer tick, asking Buildbucket for the build status
[19:44:43.022] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:43.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:15:0) after 1m0s
[19:45:43.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:15:0)
[19:45:43.105] Timer tick, asking Buildbucket for the build status
[19:45:43.285] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:43.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:16:0) after 1m0s
[19:46:43.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:16:0)
[19:46:43.390] Timer tick, asking Buildbucket for the build status
[19:46:43.571] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:43.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:17:0) after 1m0s
[19:47:43.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:17:0)
[19:47:43.593] Timer tick, asking Buildbucket for the build status
[19:47:43.792] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:43.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:18:0) after 1m0s
[19:48:43.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:18:0)
[19:48:43.863] Timer tick, asking Buildbucket for the build status
[19:48:44.028] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:44.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:19:0) after 1m0s
[19:49:44.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:19:0)
[19:49:44.014] Timer tick, asking Buildbucket for the build status
[19:49:44.187] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:44.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:20:0) after 1m0s
[19:50:44.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:20:0)
[19:50:44.233] Timer tick, asking Buildbucket for the build status
[19:50:45.109] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:45.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:21:0) after 1m0s
[19:51:45.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:21:0)
[19:51:45.210] Timer tick, asking Buildbucket for the build status
[19:51:47.312] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:22:0) after 1m0s
[19:52:47.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:22:0)
[19:52:47.381] Timer tick, asking Buildbucket for the build status
[19:52:47.899] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:47.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:23:0) after 1m0s
[19:53:48.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:23:0)
[19:53:48.055] Timer tick, asking Buildbucket for the build status
[19:53:49.754] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:49.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:24:0) after 1m0s
[19:54:49.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:24:0)
[19:54:49.890] Timer tick, asking Buildbucket for the build status
[19:54:50.148] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:50.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:25:0) after 1m0s
[19:55:50.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:25:0)
[19:55:50.231] Timer tick, asking Buildbucket for the build status
[19:55:52.489] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:52.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:26:0) after 1m0s
[19:56:52.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:26:0)
[19:56:52.526] Timer tick, asking Buildbucket for the build status
[19:56:52.679] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:52.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:27:0) after 1m0s
[19:57:52.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:27:0)
[19:57:52.798] Timer tick, asking Buildbucket for the build status
[19:57:52.944] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:52.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:28:0) after 1m0s
[19:58:53.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:28:0)
[19:58:53.093] Timer tick, asking Buildbucket for the build status
[19:58:55.544] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:55.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:29:0) after 1m0s
[19:59:55.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:29:0)
[19:59:55.616] Timer tick, asking Buildbucket for the build status
[19:59:55.760] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:55.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:30:0) after 1m0s
[20:00:55.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:30:0)
[20:00:55.833] Timer tick, asking Buildbucket for the build status
[20:00:56.020] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:56.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:31:0) after 1m0s
[20:01:56.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:31:0)
[20:01:56.087] Timer tick, asking Buildbucket for the build status
[20:01:56.237] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:56.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:32:0) after 1m0s
[20:02:56.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:32:0)
[20:02:56.864] Timer tick, asking Buildbucket for the build status
[20:02:57.396] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:57.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:33:0) after 1m0s
[20:03:57.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:33:0)
[20:03:57.800] Timer tick, asking Buildbucket for the build status
[20:03:57.991] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:57.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:34:0) after 1m0s
[20:04:58.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:34:0)
[20:04:58.186] Timer tick, asking Buildbucket for the build status
[20:04:58.351] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:58.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:35:0) after 1m0s
[20:05:58.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:35:0)
[20:05:58.515] Timer tick, asking Buildbucket for the build status
[20:05:58.763] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:58.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:36:0) after 1m0s
[20:06:59.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:36:0)
[20:06:59.155] Timer tick, asking Buildbucket for the build status
[20:06:59.479] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:59.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:37:0) after 1m0s
[20:07:59.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:37:0)
[20:07:59.895] Timer tick, asking Buildbucket for the build status
[20:08:00.103] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:00.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:38:0) after 1m0s
[20:09:00.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:38:0)
[20:09:00.228] Timer tick, asking Buildbucket for the build status
[20:09:00.530] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:39:0) after 1m0s
[20:10:00.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:39:0)
[20:10:00.587] Timer tick, asking Buildbucket for the build status
[20:10:01.202] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:40:0) after 1m0s
[20:11:01.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:40:0)
[20:11:01.252] Timer tick, asking Buildbucket for the build status
[20:11:01.413] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:01.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:41:0) after 1m0s
[20:12:01.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:41:0)
[20:12:01.528] Timer tick, asking Buildbucket for the build status
[20:12:02.146] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:02.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:42:0) after 1m0s
[20:13:02.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:42:0)
[20:13:02.265] Timer tick, asking Buildbucket for the build status
[20:13:02.408] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:02.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:43:0) after 1m0s
[20:14:02.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:43:0)
[20:14:02.477] Timer tick, asking Buildbucket for the build status
[20:14:03.041] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:03.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:44:0) after 1m0s
[20:15:03.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:44:0)
[20:15:03.088] Timer tick, asking Buildbucket for the build status
[20:15:03.697] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:03.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:45:0) after 1m0s
[20:16:03.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:45:0)
[20:16:03.711] Timer tick, asking Buildbucket for the build status
[20:16:04.367] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:04.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:46:0) after 1m0s
[20:17:04.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:46:0)
[20:17:04.429] Timer tick, asking Buildbucket for the build status
[20:17:04.650] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:04.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:47:0) after 1m0s
[20:18:04.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:47:0)
[20:18:04.714] Timer tick, asking Buildbucket for the build status
[20:18:05.407] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:05.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:48:0) after 1m0s
[20:19:05.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:48:0)
[20:19:05.436] Timer tick, asking Buildbucket for the build status
[20:19:05.628] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:05.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:49:0) after 1m0s
[20:20:05.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:49:0)
[20:20:05.769] Timer tick, asking Buildbucket for the build status
[20:20:05.902] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:05.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:50:0) after 1m0s
[20:21:05.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:50:0)
[20:21:05.923] Timer tick, asking Buildbucket for the build status
[20:21:06.245] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:06.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:51:0) after 1m0s
[20:22:06.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:51:0)
[20:22:06.235] Timer tick, asking Buildbucket for the build status
[20:22:08.775] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:08.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:52:0) after 1m0s
[20:23:08.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:52:0)
[20:23:08.944] Timer tick, asking Buildbucket for the build status
[20:23:09.235] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:09.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:53:0) after 1m0s
[20:24:09.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:53:0)
[20:24:09.369] Timer tick, asking Buildbucket for the build status
[20:24:09.684] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:09.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:54:0) after 1m0s
[20:25:09.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:54:0)
[20:25:09.871] Timer tick, asking Buildbucket for the build status
[20:25:10.683] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:10.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:55:0) after 1m0s
[20:26:10.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:55:0)
[20:26:10.865] Timer tick, asking Buildbucket for the build status
[20:26:11.186] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:11.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:56:0) after 1m0s
[20:27:11.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:56:0)
[20:27:11.241] Timer tick, asking Buildbucket for the build status
[20:27:11.375] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:57:0) after 1m0s
[20:28:11.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:57:0)
[20:28:11.420] Timer tick, asking Buildbucket for the build status
[20:28:11.803] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:11.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:58:0) after 1m0s
[20:29:11.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:58:0)
[20:29:11.900] Timer tick, asking Buildbucket for the build status
[20:29:12.626] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:59:0) after 1m0s
[20:30:12.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:59:0)
[20:30:12.642] Timer tick, asking Buildbucket for the build status
[20:30:12.987] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:60:0) after 1m0s
[20:31:13.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:60:0)
[20:31:13.023] Timer tick, asking Buildbucket for the build status
[20:31:13.172] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:13.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:61:0) after 1m0s
[20:32:13.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:61:0)
[20:32:13.189] Timer tick, asking Buildbucket for the build status
[20:32:13.631] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:13.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:62:0) after 1m0s
[20:33:13.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:62:0)
[20:33:13.752] Timer tick, asking Buildbucket for the build status
[20:33:16.613] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:63:0) after 1m0s
[20:34:16.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:63:0)
[20:34:16.677] Timer tick, asking Buildbucket for the build status
[20:34:17.301] Build 8888814263641511744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:17.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054244325899002352:64:0) after 1m0s
[20:35:04.315] Received PubSub notification, asking Buildbucket for the build status
[20:35:04.430] Build 8888814263641511744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:35:04.430] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581366903530037",
"created_by": "project:chromium",
"created_ts": "1581363155667264",
"id": "8888814263641511744",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ef8fcb1ae40589d4e1c700bfa4050f7343199fe\"}}",
"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-63-nmsh\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168462, \"got_angle_revision\": \"fc1e8503d88b8cfaa35610c382f0265be163f54a\", \"got_dawn_revision\": \"fb01a6024e4d8ba45047baa410783f7774e6cd9e\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7ef8fcb1ae40589d4e1c700bfa4050f7343199fe\", \"got_revision_cp\": \"refs/heads/master@{#739968}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"b3b2a4fc756f8f6dca980c75d785e06134b9d5f8\", \"got_v8_revision\": \"d0da7b4db4d335d91a374ec3be53199c482e7174\", \"got_v8_revision_cp\": \"refs/heads/8.2.56@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ef8fcb1ae40589d4e1c700bfa4050f7343199fe\", \"swarm_hashes_refs/heads/master(at){#739968}_without_patch\": {\"accessibility_unittests\": \"521bc1780dc0b9abeb2625ba181a283e2e9ddfaa\", \"angle_unittests\": \"9bed93b3ff097bf3354a9386be8318a6b2c771f9\", \"app_shell_unittests\": \"3e7774ac3db2cd1fc9ee68c822aeb74a85c3cd10\", \"aura_unittests\": \"585f0b340a2e4b3dae6eda015b2033b5551a857a\", \"base_unittests\": \"b4a25a59f6260d9bfe532fc60d79dc8a2774fcc5\", \"base_util_unittests\": \"39dc6513396b0eaa1e1c762ae38e9df8602b2578\", \"blink_common_unittests\": \"f65cbf66761fbed189017f607db3431c7fe6c4e1\", \"blink_fuzzer_unittests\": \"345d02f9b0324e88dc4b58d36c4ac5ce50927029\", \"blink_heap_unittests\": \"7dd32c4b03343f88eee8963a0d464980abe04bf2\", \"blink_platform_unittests\": \"0c8ebdc3774370d9a99cead1acedb5b2c17eb7b0\", \"blink_python_tests\": \"f1e2e05b29e55e87145863e8c4ddd0485edc685e\", \"blink_unittests\": \"58fa095ac06ce66d90551bf9314529622665ef1b\", \"blink_web_tests\": \"e127f631fa4ecd69d97fc0cfe4bec85399142bfd\", \"boringssl_crypto_tests\": \"b1df0a2d21f8b4d3ed8df59b18bb31e2aa536ea6\", \"boringssl_ssl_tests\": \"57845d3f63f48767eea1681b056c279b4f61e347\", \"browser_tests\": \"a430e487a9630ac83c4d1517b8e518ab8c121cfe\", \"cacheinvalidation_unittests\": \"cd2b707d95251cd03159610ca3b6bdd7f8aa7337\", \"capture_unittests\": \"ecc977836e3892668708fdd2e607139d191581f1\", \"cast_unittests\": \"d58cd46bf87741ae8751609637b948d6b703750f\", \"cc_unittests\": \"e1204c532afd51fd52d3aace748b809bcb185f16\", \"chrome_app_unittests\": \"3bbf630e52ce1108f623bdb2866380d159d56761\", \"chromedriver_unittests\": \"c9ca407ea71176aaf049e37a9d220aba66789190\", \"components_browsertests\": \"0e3e731a05ed23e9a792bd3f8fa86808a3dd4161\", \"components_unittests\": \"0726d42bb8816f30e7455bf281b21636dcbbebe5\", \"compositor_unittests\": \"94579601b19c0891636b9c196192ee984ad857fa\", \"content_browsertests\": \"96d671e114c525f03880896b251ddfdbbbede34c\", \"content_shell_crash_test\": \"aeb417cbf63b4b1721170e0ebcc91ec6ba91a6ea\", \"content_unittests\": \"f37b65434dc4b8d399aca3b592952fff8424834d\", \"crashpad_tests\": \"62b9398fe67834e0b6dec8c8a303821e2c605b28\", \"cronet_tests\": \"586dd00ead461c3d655af44ddb94e442b3d23bc2\", \"cronet_unittests\": \"ef05fa2c1cc2e44d1f65f6a06356577ccb297b01\", \"crypto_unittests\": \"09d04f9b9f7973d56a189b43d307759aff4269bf\", \"dbus_unittests\": \"fe55544f15cc914f9c93187578e9420cf8f18053\", \"device_unittests\": \"368be17a3a6077b2054a7e7fa6e023b2563b3e3d\", \"display_unittests\": \"276adae0dad093c6ade5eb8222ba7e120a00b4fc\", \"events_unittests\": \"6d4ac10fe76473ae0bb727aeb945516199c5ca0c\", \"extensions_browsertests\": \"70578c16feb0d25f62f939f861f6a68d2b70cdcf\", \"extensions_unittests\": \"91e119471d0bb4988fa6f07a6c66cbc41fca2c42\", \"filesystem_service_unittests\": \"d8750ceff7df048a0cd50114d2f2e4d480906e71\", \"flatbuffers_unittests\": \"e0b6595529551438a032f600cb9a377756ae2cbe\", \"gcm_unit_tests\": \"32fd4229bb4379d1822055c5459094461af46488\", \"gfx_unittests\": \"adb653afb28a7018d83560bb9c3fd0976cba3f13\", \"gin_unittests\": \"ce1b8cf0cce870cd798a34bcd3fec571ad56dc99\", \"google_apis_unittests\": \"25b5dfd3326691ef1b87e2fc067446c39c766be9\", \"gpu_unittests\": \"a3715eec97eb3673a0604be790d105b8f338334e\", \"grit_python_unittests\": \"ce1bc9b2b1828ea6d70230d85827604381bdc55d\", \"gwp_asan_unittests\": \"6e69123770a5070445c8c32f36cae4b77f34a9a0\", \"headless_browsertests\": \"868d73ddb051f7b3cb0a77432649061ecb9f8e07\", \"headless_unittests\": \"ba061ef4271825dd434cdd57175fdd8bc778b19c\", \"interactive_ui_tests\": \"ad34a7b68eace48f4d0d36d5fd1b61ea94cfc13b\", \"ipc_tests\": \"33dacb8e15b61f78c19c389a25cff20ec7f765d7\", \"jingle_unittests\": \"f549e18f3e3ffa6b457b5ebe22220d06f39ea949\", \"latency_unittests\": \"82c6262ae387fffe26ac25775339e02adc801aed\", \"libjingle_xmpp_unittests\": \"4c7fbaf8214558e9f7101974abe3ee0ee8426df2\", \"media_blink_unittests\": \"e3ff4b63ba2913a5ba231aed3afaa15142f3d8a1\", \"media_service_unittests\": \"b055e0a54e94a10c50f8a1187027acde75f43286\", \"media_unittests\": \"15996fd6863c923f82d31fa295378ec024c07e74\", \"message_center_unittests\": \"41eaf12e8c627eb247b6eec611acbbc6d5bd7368\", \"metrics_python_tests\": \"52f0088cc000401062f76b77069044a800c15469\", \"midi_unittests\": \"3364f0ab137283e2f45a71a67910d98246e66795\", \"mojo_core_unittests\": \"0ff015e8dbd61f3cf087fce35b99d5aa4aff4a7f\", \"mojo_unittests\": \"4dcdc707769771aeaca1fa08877618ef43dae58a\", \"nacl_helper_nonsfi_unittests\": \"55ecd3704611d76da1d7ea55a6742fe35feb3644\", \"nacl_loader_unittests\": \"c78caba543c5e9f2c55cbcbfa2c5bf0e4791f75d\", \"native_theme_unittests\": \"a6cd47dd5b9dd9671a6a7fc94af24c698cf9b868\", \"net_unittests\": \"55d1908a6e6e1bc565d08596d7a07abc7bc2a34b\", \"pdf_unittests\": \"61030c097b5cc98d5fdf7947af36988dc14931ec\", \"perfetto_unittests\": \"63c72d750c6454c203152f4fd5ba82afb581befc\", \"ppapi_unittests\": \"1e3a24755a816cb31a8c7014f06fe3f88bcf23eb\", \"printing_unittests\": \"9e9dba959baa62ec5cec0656c112516ecf46a357\", \"remoting_unittests\": \"584679d837310cfd6989826893570632cb361300\", \"sandbox_linux_unittests\": \"27addec9ba85f84b5b272ebc77d76854d6a042f3\", \"service_manager_unittests\": \"3ddc72578ad71a38e3f5c853b8bba840659730ab\", \"services_unittests\": \"8d75f462370be4132520a5f7834e36b514127884\", \"shell_dialogs_unittests\": \"05a92bf24f5a7169eadc26f988364fd20756edd4\", \"skia_unittests\": \"f3f703f1f870d1f1c1f2c634d6fc53758f33df56\", \"snapshot_unittests\": \"72336129e38851a4a867769099516212b1bcf53a\", \"sql_unittests\": \"8bab093962a7af1ea55e0bfd1e7d0f8236e6cc3d\", \"storage_unittests\": \"d5fae40ace2386efeeb0a25d80deae3740da488d\", \"sync_integration_tests\": \"7b454e2fcfd5810d664cf012258911c6fb496c68\", \"telemetry_gpu_unittests\": \"74ed7502526008ada2f15a065e680b5c484348fe\", \"telemetry_perf_unittests\": \"10be756187a8b6115197bce9ca47e9086052a491\", \"telemetry_unittests\": \"a162a8647a79061987f35916f6a433c55eab4cd9\", \"traffic_annotation_auditor_unittests\": \"4ec36cc891d9b5d81cdeee70d5ba503d90682294\", \"ui_base_unittests\": \"2b2fd424bc65072d871f817e4d2b8325d236d74c\", \"ui_touch_selection_unittests\": \"a6b9d8398d0e61c1e38a4cc1c6e7a023f7a50e26\", \"unit_tests\": \"e468040212d2986bd57dfeb907b44de6969d2a8a\", \"url_unittests\": \"86f3b6098dd3de3c782c788d431b5539046919c5\", \"views_perftests\": \"04af7f77a20333a6d09523e74eaab4ea48577d83\", \"views_unittests\": \"d95a76f9ac69cd749780594a95e79fb44d5be439\", \"viz_unittests\": \"b9a8f03b3a99662c008a8b72dea6122a75cbb737\", \"vr_common_unittests\": \"1075fc2ea67958f909163260af4e79787685a6b8\", \"vr_pixeltests\": \"43f98d3fb792d1c85ce9e509275270bb5789d82b\", \"webdriver_wpt_tests\": \"f49319b858ed11a3d088f64caa035b8486d38984\", \"weblayer_browsertests\": \"58faa86b077de95763443859b581346d00ba8146\", \"wm_unittests\": \"e776f84dab429a90ce43c711ee7f6ff174a9b1b8\", \"wtf_unittests\": \"a4162f678e9cea8e41990e72a5d3bc8e608311f8\", \"xr_browser_tests\": \"970af5451159322178dcd99f9b84062dac2da627\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e7d7e672723aea6cc752b70abb9e3aec1540865d07a8c2471e48d2b0cb9abe3_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_a050691f36f3646c8cc368108f8edcf844a0d1683dc4a3731c64b1c7527ccb94_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_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-63-nmsh\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581363465786713",
"status": "COMPLETED",
"status_changed_ts": "1581366903821465",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168462",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef8fcb1ae40589d4e1c700bfa4050f7343199fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054244325899002352",
"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/8888814263641511744/+/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:4a49685e4a4c5110",
"user_agent:luci-scheduler"
],
"updated_ts": "1581366903825870",
"url": "https://ci.chromium.org/b/8888814263641511744",
"utcnow_ts": "1581366904417817"
}
}
[20:35:04.430] Invocation finished in 1h2m30.298412889s with status SUCCEEDED