[05:20:01.919] New invocation is queued and will start shortly
[05:20:03.135] Starting the invocation (attempt 1)
[05:20:03.202] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:20:03.202] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:20:03.202] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050039905477902000",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"422a0bbbf718ff3d2e4b2dc45c7cad692f332975\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050039905477902000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"gitiles_ref:refs/heads/master"
]
}
[05:20:04.281] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585372803315461",
"id": "8884609843349365056",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"422a0bbbf718ff3d2e4b2dc45c7cad692f332975\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585372804017601",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170295",
"builder:Linux Builder (dbg)",
"buildset:commit/git/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050039905477902000",
"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/8884609843349365056/+/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": "1585372804017801",
"url": "https://ci.chromium.org/b/8884609843349365056",
"utcnow_ts": "1585372804179389"
}
}
[05:20:04.281] Task URL: https://ci.chromium.org/b/8884609843349365056
[05:20:04.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:2:0) after 1m0s
[05:21:04.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:2:0)
[05:21:04.409] Timer tick, asking Buildbucket for the build status
[05:21:04.738] Build 8884609843349365056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:04.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:3:0) after 1m0s
[05:22:04.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:3:0)
[05:22:04.800] Timer tick, asking Buildbucket for the build status
[05:22:05.205] Build 8884609843349365056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:05.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:4:0) after 1m0s
[05:23:05.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:4:0)
[05:23:05.279] Timer tick, asking Buildbucket for the build status
[05:23:05.469] Build 8884609843349365056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:05.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:5:0) after 1m0s
[05:24:05.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:5:0)
[05:24:05.559] Timer tick, asking Buildbucket for the build status
[05:24:05.941] Build 8884609843349365056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:05.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:6:0) after 1m0s
[05:25:02.573] Received PubSub notification, asking Buildbucket for the build status
[05:25:02.650] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:06.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:6:0)
[05:25:06.658] Timer tick, asking Buildbucket for the build status
[05:25:06.791] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:8:0) after 1m0s
[05:26:06.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:8:0)
[05:26:06.845] Timer tick, asking Buildbucket for the build status
[05:26:06.993] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:06.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:9:0) after 1m0s
[05:27:07.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:9:0)
[05:27:07.029] Timer tick, asking Buildbucket for the build status
[05:27:07.443] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:07.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:10:0) after 1m0s
[05:28:07.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:10:0)
[05:28:07.506] Timer tick, asking Buildbucket for the build status
[05:28:07.632] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:07.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:11:0) after 1m0s
[05:29:07.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:11:0)
[05:29:07.693] Timer tick, asking Buildbucket for the build status
[05:29:07.796] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:07.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:12:0) after 1m0s
[05:30:07.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:12:0)
[05:30:07.879] Timer tick, asking Buildbucket for the build status
[05:30:08.020] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:08.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:13:0) after 1m0s
[05:31:08.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:13:0)
[05:31:08.049] Timer tick, asking Buildbucket for the build status
[05:31:08.175] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:08.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:14:0) after 1m0s
[05:32:09.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:14:0)
[05:32:09.174] Timer tick, asking Buildbucket for the build status
[05:32:09.273] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:09.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:15:0) after 1m0s
[05:33:09.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:15:0)
[05:33:09.411] Timer tick, asking Buildbucket for the build status
[05:33:10.198] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:10.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:16:0) after 1m0s
[05:34:10.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:16:0)
[05:34:10.473] Timer tick, asking Buildbucket for the build status
[05:34:10.802] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:10.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:17:0) after 1m0s
[05:35:10.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:17:0)
[05:35:10.859] Timer tick, asking Buildbucket for the build status
[05:35:11.119] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:11.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:18:0) after 1m0s
[05:36:11.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:18:0)
[05:36:11.177] Timer tick, asking Buildbucket for the build status
[05:36:11.415] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:11.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:19:0) after 1m0s
[05:37:11.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:19:0)
[05:37:11.502] Timer tick, asking Buildbucket for the build status
[05:37:11.955] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:11.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:20:0) after 1m0s
[05:38:11.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:20:0)
[05:38:11.984] Timer tick, asking Buildbucket for the build status
[05:38:12.594] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:12.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:21:0) after 1m0s
[05:39:12.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:21:0)
[05:39:12.673] Timer tick, asking Buildbucket for the build status
[05:39:13.178] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:13.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:22:0) after 1m0s
[05:40:13.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:22:0)
[05:40:13.517] Timer tick, asking Buildbucket for the build status
[05:40:13.661] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:13.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:23:0) after 1m0s
[05:41:13.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:23:0)
[05:41:13.722] Timer tick, asking Buildbucket for the build status
[05:41:14.049] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:24:0) after 1m0s
[05:42:14.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:24:0)
[05:42:14.126] Timer tick, asking Buildbucket for the build status
[05:42:14.476] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:25:0) after 1m0s
[05:43:14.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:25:0)
[05:43:14.456] Timer tick, asking Buildbucket for the build status
[05:43:14.800] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:14.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:26:0) after 1m0s
[05:44:14.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:26:0)
[05:44:14.870] Timer tick, asking Buildbucket for the build status
[05:44:14.998] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:14.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:27:0) after 1m0s
[05:45:15.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:27:0)
[05:45:15.078] Timer tick, asking Buildbucket for the build status
[05:45:15.237] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:15.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:28:0) after 1m0s
[05:46:15.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:28:0)
[05:46:15.336] Timer tick, asking Buildbucket for the build status
[05:46:15.630] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:15.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:29:0) after 1m0s
[05:47:15.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:29:0)
[05:47:15.732] Timer tick, asking Buildbucket for the build status
[05:47:15.852] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:15.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:30:0) after 1m0s
[05:48:15.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:30:0)
[05:48:15.875] Timer tick, asking Buildbucket for the build status
[05:48:16.614] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:31:0) after 1m0s
[05:49:16.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:31:0)
[05:49:16.686] Timer tick, asking Buildbucket for the build status
[05:49:16.822] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:16.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:32:0) after 1m0s
[05:50:16.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:32:0)
[05:50:16.840] Timer tick, asking Buildbucket for the build status
[05:50:17.001] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:17.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:33:0) after 1m0s
[05:51:17.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:33:0)
[05:51:17.024] Timer tick, asking Buildbucket for the build status
[05:51:17.168] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:17.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:34:0) after 1m0s
[05:52:17.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:34:0)
[05:52:17.208] Timer tick, asking Buildbucket for the build status
[05:52:17.364] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:17.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:35:0) after 1m0s
[05:53:17.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:35:0)
[05:53:17.385] Timer tick, asking Buildbucket for the build status
[05:53:18.247] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:18.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:36:0) after 1m0s
[05:54:18.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:36:0)
[05:54:18.326] Timer tick, asking Buildbucket for the build status
[05:54:18.710] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:18.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:37:0) after 1m0s
[05:55:18.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:37:0)
[05:55:18.793] Timer tick, asking Buildbucket for the build status
[05:55:19.092] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:19.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:38:0) after 1m0s
[05:56:19.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:38:0)
[05:56:19.197] Timer tick, asking Buildbucket for the build status
[05:56:19.387] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:19.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:39:0) after 1m0s
[05:57:19.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:39:0)
[05:57:19.407] Timer tick, asking Buildbucket for the build status
[05:57:19.576] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:19.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:40:0) after 1m0s
[05:58:19.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:40:0)
[05:58:19.601] Timer tick, asking Buildbucket for the build status
[05:58:20.463] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:20.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:41:0) after 1m0s
[05:59:20.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:41:0)
[05:59:20.512] Timer tick, asking Buildbucket for the build status
[05:59:20.763] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:20.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:42:0) after 1m0s
[06:00:20.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:42:0)
[06:00:20.788] Timer tick, asking Buildbucket for the build status
[06:00:20.937] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:20.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:43:0) after 1m0s
[06:01:21.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:43:0)
[06:01:21.017] Timer tick, asking Buildbucket for the build status
[06:01:21.244] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:21.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:44:0) after 1m0s
[06:02:21.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:44:0)
[06:02:21.296] Timer tick, asking Buildbucket for the build status
[06:02:21.586] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:21.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:45:0) after 1m0s
[06:03:21.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:45:0)
[06:03:21.626] Timer tick, asking Buildbucket for the build status
[06:03:22.617] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:22.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:46:0) after 1m0s
[06:04:22.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:46:0)
[06:04:22.651] Timer tick, asking Buildbucket for the build status
[06:04:23.059] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:23.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:47:0) after 1m0s
[06:05:23.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:47:0)
[06:05:23.108] Timer tick, asking Buildbucket for the build status
[06:05:23.444] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:23.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:48:0) after 1m0s
[06:06:23.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:48:0)
[06:06:23.516] Timer tick, asking Buildbucket for the build status
[06:06:23.877] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:23.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:49:0) after 1m0s
[06:07:23.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:49:0)
[06:07:23.961] Timer tick, asking Buildbucket for the build status
[06:07:24.164] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:24.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:50:0) after 1m0s
[06:08:24.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:50:0)
[06:08:24.205] Timer tick, asking Buildbucket for the build status
[06:08:24.482] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:24.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:51:0) after 1m0s
[06:09:24.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:51:0)
[06:09:24.560] Timer tick, asking Buildbucket for the build status
[06:09:24.707] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:24.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:52:0) after 1m0s
[06:10:24.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:52:0)
[06:10:24.836] Timer tick, asking Buildbucket for the build status
[06:10:24.982] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:53:0) after 1m0s
[06:11:25.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:53:0)
[06:11:25.013] Timer tick, asking Buildbucket for the build status
[06:11:25.181] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:25.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:54:0) after 1m0s
[06:12:25.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:54:0)
[06:12:25.169] Timer tick, asking Buildbucket for the build status
[06:12:26.348] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:26.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:55:0) after 1m0s
[06:13:26.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:55:0)
[06:13:26.466] Timer tick, asking Buildbucket for the build status
[06:13:26.714] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:26.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:56:0) after 1m0s
[06:14:26.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:56:0)
[06:14:26.745] Timer tick, asking Buildbucket for the build status
[06:14:26.871] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:26.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:57:0) after 1m0s
[06:15:26.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:57:0)
[06:15:26.894] Timer tick, asking Buildbucket for the build status
[06:15:27.042] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:27.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:58:0) after 1m0s
[06:16:27.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:58:0)
[06:16:27.071] Timer tick, asking Buildbucket for the build status
[06:16:27.196] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:27.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:59:0) after 1m0s
[06:17:27.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:59:0)
[06:17:27.223] Timer tick, asking Buildbucket for the build status
[06:17:27.355] Build 8884609843349365056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:27.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050039905477902000:60:0) after 1m0s
[06:18:15.894] Received PubSub notification, asking Buildbucket for the build status
[06:18:16.862] Build 8884609843349365056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:18:16.862] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585376294939557",
"created_by": "project:chromium",
"created_ts": "1585372803315461",
"id": "8884609843349365056",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"422a0bbbf718ff3d2e4b2dc45c7cad692f332975\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-50-5apv\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170295, \"got_angle_revision\": \"10ade024031db57f34d67d4f50a3f82e5420634b\", \"got_dawn_revision\": \"81431f5034b4ce3a0cdc339709bd8ca8856fe427\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"422a0bbbf718ff3d2e4b2dc45c7cad692f332975\", \"got_revision_cp\": \"refs/heads/master@{#754289}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"de3f38a72c486c14a5cfe0810af9871acb7dec9a\", \"got_v8_revision\": \"bd43e20c8c22650fdcb84bf3e6e4543da293d07b\", \"got_v8_revision_cp\": \"refs/heads/8.3.100@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"422a0bbbf718ff3d2e4b2dc45c7cad692f332975\", \"swarm_hashes_refs/heads/master(at){#754289}_without_patch\": {\"accessibility_unittests\": \"28f24772c687c67ae2a53141867d2d6b265edff8\", \"angle_unittests\": \"f22132659a58fbe8b29d6cabad4d2ad66ee2928f\", \"app_shell_unittests\": \"4f3c0f612151bab2081cdcb12429697cf9b57e02\", \"aura_unittests\": \"cccdd3651579ea701ab2b3ee2f92c30bbd74cbae\", \"base_unittests\": \"d5e5bfc5aaaf43131d7e5bfb221ee5117d1e2189\", \"base_util_unittests\": \"11ca7e3d49437cdfdcb955c29868611e68341c1d\", \"blink_common_unittests\": \"16831dae3aa9f24a0ba01d36f46e203ed762ec58\", \"blink_fuzzer_unittests\": \"14724d579e931c7973a747e96ba012ce31b92600\", \"blink_heap_unittests\": \"d0eea923b782387ca285c105d58b712819e602e0\", \"blink_platform_unittests\": \"a6a70ee64f94b93faf5cd8cdfe9436a3032c4870\", \"blink_python_tests\": \"2589878e24dee9fbd70113c2ebc262f54a814e80\", \"blink_unittests\": \"27922143667dc8ff7d1c7157d465181e0e70e2b3\", \"blink_web_tests\": \"1e9bc73b66eda6899c8dfe7f6affd6df44f1524a\", \"boringssl_crypto_tests\": \"e8e09b9f00ab8cc00963fc373de2eafeb34ccb9d\", \"boringssl_ssl_tests\": \"d89c67ef59569381a3e683818fdaea25b5cd3db3\", \"browser_tests\": \"bae42319abf041cac730019794a054baddc1de6b\", \"cacheinvalidation_unittests\": \"f44ea7dbec6b36533fa1eccf8f19e75e875de074\", \"capture_unittests\": \"f2bef86020a6740f49a57b921a9d506cb2421ced\", \"cast_unittests\": \"fb066d12ae193bacee20bc51fe590480090640c6\", \"cc_unittests\": \"f67f466d1888f501811413bf65c5f344dc05f777\", \"chrome_app_unittests\": \"70dbc28d83d3dfa486ea1c2fec8ab4607ca455d9\", \"chromedriver_unittests\": \"e3cbaeee2fcb62e80730fc7e5a283b2dbb425e8f\", \"components_browsertests\": \"624089cf69c16295d2ad85bce7fbd2b9ae29108e\", \"components_unittests\": \"bd0be5b3cce29582e6236d43fc8b35fc8b410349\", \"compositor_unittests\": \"cc449589756c2a1e3f7fc9024ef0e0575d929d01\", \"content_browsertests\": \"a58276698b6672aea08bf4a15ee475e8e7fefa44\", \"content_shell_crash_test\": \"fb849f6962d3b7bca1904778aac33e8a0a19ce18\", \"content_unittests\": \"ad41cdbbdc27e6ca2845608331eea14956dd369d\", \"crashpad_tests\": \"a5cdcd6c71f83ed091fe450085f91aed7546b757\", \"cronet_tests\": \"7955219f1620911cbdf49028b793b21ba0b65347\", \"cronet_unittests\": \"89689a5e9ebfabd51a8457581da4f20709a6e2ff\", \"crypto_unittests\": \"2df85ac50516cef6c6f828157e9bc9972be9c5fd\", \"dbus_unittests\": \"7d34f96d0f6b889d3de407710090aa5f61b05f09\", \"device_unittests\": \"44795dfc9a6975b926fd38a3e6d00da69fce1665\", \"display_unittests\": \"66b789d7fb9177a85c49377b219e447196bac908\", \"events_unittests\": \"2cc0b140c66d79d58a1bf12e10e2558ecf47b0e6\", \"extensions_browsertests\": \"36774e1db91ae08b73c849f112659ce8bed6f8ac\", \"extensions_unittests\": \"97edbd7bf8e8b4421a07a84a02e6afb7331719e9\", \"filesystem_service_unittests\": \"e21199e0e5ab35e71ab7666f2e2c7baf0c3622a5\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"0b2e46c923d0da7afd6052de0ed115c682dc3652\", \"gfx_unittests\": \"6e638165746c9d9813c598ee253eec675b643992\", \"gin_unittests\": \"e38928a530da5819d3c41402e19514d27b823508\", \"google_apis_unittests\": \"06e3f073ba7139a6b13987350c316acbb46da929\", \"gpu_unittests\": \"7208ce63f3395e84315df300c457ae020f422575\", \"grit_python_unittests\": \"4b6762478187600b0d776425ac36aaa43e7b6bc1\", \"gwp_asan_unittests\": \"e2cb286d8fdc32101d0fac7df00663dea6cc38fe\", \"headless_browsertests\": \"7763bb07a5c0511ed3eb28718d584d2ea7c80fa5\", \"headless_unittests\": \"4487930f0a39fb5ca07fe0e1e3281563a8ddb090\", \"interactive_ui_tests\": \"5a21891a086fa767c8599a8af7f3cc73ec1e7651\", \"ipc_tests\": \"afd8f266d5960e9ff9d53344647a8ac8a3702b10\", \"jingle_unittests\": \"02659bbd3b5b5cef652e8087d71be64cf5f92a25\", \"latency_unittests\": \"6ab9bada187957eb106adebebf5fc76920a0a215\", \"libjingle_xmpp_unittests\": \"ed7181b0edccf77ed545ea2f5905bfc61c67bac6\", \"media_blink_unittests\": \"61134cd8813f6d90e50fec22f5b1c9bf77325e61\", \"media_unittests\": \"1a12b304c826f6860a9f77202ca7a3fc74e97465\", \"message_center_unittests\": \"894419b9e428da723bfdb805ce56381bf35fcbd3\", \"metrics_python_tests\": \"c75734497ce169a9fa43cf7d5320a6c5f239e11a\", \"midi_unittests\": \"6aad2b90d48007c4e2372007705840ca8bca6d58\", \"mojo_core_unittests\": \"7530e9c6f29b6f87851079ec6c05d7a29c40aaf7\", \"mojo_unittests\": \"0b556e4f62018a82ea824494ca5f2de8961b426d\", \"nacl_helper_nonsfi_unittests\": \"dea35ff9e2723e143e9130360833f64ab82a7061\", \"nacl_loader_unittests\": \"411f69fc96f6f53f3c0ec3bbb132fe6371ff1dfa\", \"native_theme_unittests\": \"df841d9529712a959d1366c303f91f02e8b41d2e\", \"net_unittests\": \"6d7ca87bca69940f2e258bfce82eba8dacf3806b\", \"pdf_unittests\": \"215d9338c0e5a4e807bf3d1100744bb728f0b0d6\", \"perfetto_unittests\": \"322a911fde851662b885ef140c566ce41c76b8c9\", \"ppapi_unittests\": \"b9e535763c66c62c08911c4dd677e0fc9075d406\", \"printing_unittests\": \"7ce018c1330fd7bf494f20f3b008f58a5bd0e429\", \"remoting_unittests\": \"c0c4891e53f5e8b92bff4f3375cadc463a6a6359\", \"sandbox_linux_unittests\": \"2a46841807b673394d78fb9a8c32ca6c73fb7af5\", \"service_manager_unittests\": \"655fac2ed6a5364d3e89ad4495829f97fbd1780a\", \"services_unittests\": \"d5153221e1f7c46ddcb7721117b570a73f94bb0e\", \"shell_dialogs_unittests\": \"af33b39d7dc73d422fafbeab448ff79037a1b936\", \"skia_unittests\": \"6bfb386e34ba8bb4f8a48d44344084411fb91c22\", \"snapshot_unittests\": \"09dd923bca770a442f8a714f8d42e40a27f0ea8f\", \"sql_unittests\": \"0773b1c479d7982c5519f1127ec5ea70b4cf03fe\", \"storage_unittests\": \"c709de4d94446eb66c908b3e2b5c348a6feba46c\", \"sync_integration_tests\": \"26853880ec0184630620b454dfa616a232af64ea\", \"telemetry_gpu_unittests\": \"55cfd0b9cbd8fbc6edd9740273ec28c3c3f848c3\", \"telemetry_perf_unittests\": \"4701851f4ff3963c0dcaf85febb7c24b923443e8\", \"telemetry_unittests\": \"80657909ea4ea98d1d02ea2a68769f3ada73bfd9\", \"traffic_annotation_auditor_unittests\": \"5184d7de74075a9e234feb009ce7ed88d37435ad\", \"ui_base_unittests\": \"cbd120deff5cde4339821fcf496e60d50a19a7d6\", \"ui_touch_selection_unittests\": \"b322b4c1c183982a19f8114c35b4d8dae1724cab\", \"unit_tests\": \"2bce78597c660e9d3729fa3288a5129097a1ca6e\", \"url_unittests\": \"38f4c474a34069f928bc9792302e6a4b03b9eb54\", \"views_perftests\": \"aa8081b3324f5948ce787b7fb7db38eae25c5670\", \"views_unittests\": \"3c0464a863cf1b5ab333e767d39e39d1cfe4656a\", \"viz_unittests\": \"772d2cfa0ad7fb65db3a73ed8bc269f93c850696\", \"vr_common_unittests\": \"13658cad8a3685770c01fa69b4a5284df1acdd18\", \"vr_pixeltests\": \"82a96781ee6b657984b741e7f025509f051a3de5\", \"webdriver_wpt_tests\": \"3c6068d2a420feb2ef690428721a929424db7da6\", \"weblayer_browsertests\": \"803ec98ab3ee7524281048c4f8ed596cb038ed21\", \"wm_unittests\": \"9b47868538ee5dda4df6adb86b15ed03dae17afa\", \"wtf_unittests\": \"43d38df45710a2b1bea64b0683447c767819de90\", \"xr_browser_tests\": \"e0f187240f02f02b43ce2315d8bee52c4a5cd77c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_5c30bb016a77fbc5ea3e6fb824c869c1bb0f4222c21aad0a92d459b086fbc996_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_859368e171259d521efea13da6023dc28f5117d74d565299fe323cf1e9b3ffc9_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-50-5apv\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4901-91f024a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585373101469698",
"status": "COMPLETED",
"status_changed_ts": "1585376295269589",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170295",
"builder:Linux Builder (dbg)",
"buildset:commit/git/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/422a0bbbf718ff3d2e4b2dc45c7cad692f332975",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050039905477902000",
"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/8884609843349365056/+/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:4b3866bccf33d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1585376295278117",
"url": "https://ci.chromium.org/b/8884609843349365056",
"utcnow_ts": "1585376296836166"
}
}
[06:18:16.862] Invocation finished in 58m14.960529702s with status SUCCEEDED