[17:18:14.964] New invocation is queued and will start shortly
[17:18:16.209] Starting the invocation (attempt 1)
[17:18:16.275] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:18:16.275] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:18:16.275] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029882192607952000",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fc84917dd7e7b435fce90ddc4b2d61a76279b429\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9029882192607952000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"gitiles_ref:refs/heads/master"
]
}
[17:18:16.919] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604596696409403",
"id": "8864452130424319552",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc84917dd7e7b435fce90ddc4b2d61a76279b429\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604596696793515",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177391",
"builder:Linux Builder (dbg)",
"buildset:commit/git/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029882192607952000",
"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/8864452130424319552/+/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": "1604596696793635",
"url": "https://ci.chromium.org/b/8864452130424319552",
"utcnow_ts": "1604596696904018"
}
}
[17:18:16.919] Task URL: https://ci.chromium.org/b/8864452130424319552
[17:18:16.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:2:0) after 1m0s
[17:19:07.680] Received PubSub notification, asking Buildbucket for the build status
[17:19:07.811] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:17.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:2:0)
[17:19:17.045] Timer tick, asking Buildbucket for the build status
[17:19:18.483] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:18.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:4:0) after 1m0s
[17:20:18.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:4:0)
[17:20:18.742] Timer tick, asking Buildbucket for the build status
[17:20:19.015] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:19.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:5:0) after 1m0s
[17:21:19.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:5:0)
[17:21:19.002] Timer tick, asking Buildbucket for the build status
[17:21:19.062] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:19.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:6:0) after 1m0s
[17:22:19.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:6:0)
[17:22:19.269] Timer tick, asking Buildbucket for the build status
[17:22:19.421] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:19.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:7:0) after 1m0s
[17:23:19.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:7:0)
[17:23:19.536] Timer tick, asking Buildbucket for the build status
[17:23:19.666] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:19.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:8:0) after 1m0s
[17:24:19.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:8:0)
[17:24:19.702] Timer tick, asking Buildbucket for the build status
[17:24:19.825] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:19.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:9:0) after 1m0s
[17:25:19.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:9:0)
[17:25:19.888] Timer tick, asking Buildbucket for the build status
[17:25:20.217] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:20.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:10:0) after 1m0s
[17:26:20.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:10:0)
[17:26:20.276] Timer tick, asking Buildbucket for the build status
[17:26:20.368] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:20.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:11:0) after 1m0s
[17:27:20.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:11:0)
[17:27:20.437] Timer tick, asking Buildbucket for the build status
[17:27:20.511] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:20.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:12:0) after 1m0s
[17:28:20.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:12:0)
[17:28:20.549] Timer tick, asking Buildbucket for the build status
[17:28:21.012] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:21.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:13:0) after 1m0s
[17:29:21.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:13:0)
[17:29:21.040] Timer tick, asking Buildbucket for the build status
[17:29:21.126] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:21.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:14:0) after 1m0s
[17:30:21.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:14:0)
[17:30:21.356] Timer tick, asking Buildbucket for the build status
[17:30:21.459] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:21.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:15:0) after 1m0s
[17:31:21.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:15:0)
[17:31:21.577] Timer tick, asking Buildbucket for the build status
[17:31:21.648] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:21.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:16:0) after 1m0s
[17:32:21.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:16:0)
[17:32:21.655] Timer tick, asking Buildbucket for the build status
[17:32:21.729] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:21.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:17:0) after 1m0s
[17:33:21.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:17:0)
[17:33:21.939] Timer tick, asking Buildbucket for the build status
[17:33:22.065] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:22.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:18:0) after 1m0s
[17:34:22.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:18:0)
[17:34:22.369] Timer tick, asking Buildbucket for the build status
[17:34:22.459] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:22.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:19:0) after 1m0s
[17:35:22.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:19:0)
[17:35:22.534] Timer tick, asking Buildbucket for the build status
[17:35:22.598] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:20:0) after 1m0s
[17:36:23.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:20:0)
[17:36:23.210] Timer tick, asking Buildbucket for the build status
[17:36:23.284] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:23.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:21:0) after 1m0s
[17:37:23.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:21:0)
[17:37:23.603] Timer tick, asking Buildbucket for the build status
[17:37:23.685] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:23.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:22:0) after 1m0s
[17:38:23.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:22:0)
[17:38:23.893] Timer tick, asking Buildbucket for the build status
[17:38:23.992] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:23:0) after 1m0s
[17:39:24.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:23:0)
[17:39:24.251] Timer tick, asking Buildbucket for the build status
[17:39:24.322] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:24:0) after 1m0s
[17:40:24.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:24:0)
[17:40:24.784] Timer tick, asking Buildbucket for the build status
[17:40:24.856] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:24.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:25:0) after 1m0s
[17:41:25.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:25:0)
[17:41:25.177] Timer tick, asking Buildbucket for the build status
[17:41:25.279] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:25.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:26:0) after 1m0s
[17:42:25.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:26:0)
[17:42:25.702] Timer tick, asking Buildbucket for the build status
[17:42:25.827] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:25.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:27:0) after 1m0s
[17:43:28.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:27:0)
[17:43:28.277] Timer tick, asking Buildbucket for the build status
[17:43:28.607] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:28.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:28:0) after 1m0s
[17:44:28.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:28:0)
[17:44:28.615] Timer tick, asking Buildbucket for the build status
[17:44:28.697] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:28.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:29:0) after 1m0s
[17:45:28.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:29:0)
[17:45:28.786] Timer tick, asking Buildbucket for the build status
[17:45:28.973] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:30:0) after 1m0s
[17:46:29.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:30:0)
[17:46:29.023] Timer tick, asking Buildbucket for the build status
[17:46:30.280] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:30.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:31:0) after 1m0s
[17:47:30.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:31:0)
[17:47:30.466] Timer tick, asking Buildbucket for the build status
[17:47:30.559] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:30.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:32:0) after 1m0s
[17:48:30.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:32:0)
[17:48:30.616] Timer tick, asking Buildbucket for the build status
[17:48:30.725] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:30.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:33:0) after 1m0s
[17:49:30.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:33:0)
[17:49:30.774] Timer tick, asking Buildbucket for the build status
[17:49:30.844] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:30.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:34:0) after 1m0s
[17:50:30.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:34:0)
[17:50:30.935] Timer tick, asking Buildbucket for the build status
[17:50:31.013] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:31.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:35:0) after 1m0s
[17:51:31.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:35:0)
[17:51:31.109] Timer tick, asking Buildbucket for the build status
[17:51:31.764] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:31.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:36:0) after 1m0s
[17:52:31.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:36:0)
[17:52:31.871] Timer tick, asking Buildbucket for the build status
[17:52:31.943] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:31.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:37:0) after 1m0s
[17:53:32.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:37:0)
[17:53:32.034] Timer tick, asking Buildbucket for the build status
[17:53:32.223] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:32.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:38:0) after 1m0s
[17:54:32.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:38:0)
[17:54:32.224] Timer tick, asking Buildbucket for the build status
[17:54:32.288] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:32.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:39:0) after 1m0s
[17:55:32.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:39:0)
[17:55:32.369] Timer tick, asking Buildbucket for the build status
[17:55:32.447] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:32.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:40:0) after 1m0s
[17:56:32.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:40:0)
[17:56:32.489] Timer tick, asking Buildbucket for the build status
[17:56:32.624] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:32.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:41:0) after 1m0s
[17:57:32.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:41:0)
[17:57:32.681] Timer tick, asking Buildbucket for the build status
[17:57:32.752] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:32.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:42:0) after 1m0s
[17:58:32.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:42:0)
[17:58:32.859] Timer tick, asking Buildbucket for the build status
[17:58:32.982] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:32.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:43:0) after 1m0s
[17:59:33.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:43:0)
[17:59:33.022] Timer tick, asking Buildbucket for the build status
[17:59:33.353] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:33.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:44:0) after 1m0s
[18:00:33.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:44:0)
[18:00:33.409] Timer tick, asking Buildbucket for the build status
[18:00:33.779] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:33.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:45:0) after 1m0s
[18:01:33.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:45:0)
[18:01:33.774] Timer tick, asking Buildbucket for the build status
[18:01:33.863] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:33.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:46:0) after 1m0s
[18:02:33.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:46:0)
[18:02:33.911] Timer tick, asking Buildbucket for the build status
[18:02:34.046] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:34.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:47:0) after 1m0s
[18:03:34.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:47:0)
[18:03:34.231] Timer tick, asking Buildbucket for the build status
[18:03:34.513] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:34.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:48:0) after 1m0s
[18:04:34.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:48:0)
[18:04:34.573] Timer tick, asking Buildbucket for the build status
[18:04:34.667] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:34.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:49:0) after 1m0s
[18:05:34.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:49:0)
[18:05:34.742] Timer tick, asking Buildbucket for the build status
[18:05:34.838] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:34.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:50:0) after 1m0s
[18:06:34.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:50:0)
[18:06:34.820] Timer tick, asking Buildbucket for the build status
[18:06:34.938] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:34.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:51:0) after 1m0s
[18:07:35.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:51:0)
[18:07:35.027] Timer tick, asking Buildbucket for the build status
[18:07:35.168] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:35.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:52:0) after 1m0s
[18:08:35.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:52:0)
[18:08:35.189] Timer tick, asking Buildbucket for the build status
[18:08:35.313] Build 8864452130424319552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:35.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029882192607952000:53:0) after 1m0s
[18:08:55.723] Received PubSub notification, asking Buildbucket for the build status
[18:08:55.819] Build 8864452130424319552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:08:55.819] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604599734946577",
"created_by": "project:chromium",
"created_ts": "1604596696409403",
"id": "8864452130424319552",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc84917dd7e7b435fce90ddc4b2d61a76279b429\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"fc84917dd7e7b435fce90ddc4b2d61a76279b429\", \"project\": \"chromium/src\"}], \"$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-86-hldt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177391, \"got_angle_revision\": \"3942e801a65b780296f526f10704c9668d499942\", \"got_dawn_revision\": \"d42713de7aa3227f1feb405beddac4e37051b679\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"fc84917dd7e7b435fce90ddc4b2d61a76279b429\", \"got_revision_cp\": \"refs/heads/master@{#824461}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ad54c71632cc0f18584a7009f1e6fc44f5453bc7\", \"got_v8_revision\": \"937e42d5f246b3d04092869127d2888668de7acd\", \"got_v8_revision_cp\": \"refs/heads/8.8.239@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc84917dd7e7b435fce90ddc4b2d61a76279b429\", \"swarm_hashes_refs/heads/master(at){#824461}_without_patch\": {\"absl_hardening_tests\": \"57178d498599564a97c2b472ceb3cffb6478ddb4\", \"accessibility_unittests\": \"37695c8eaf56e2d9a594f6bda0a4a799c0ba08f1\", \"angle_unittests\": \"e72d538f9282b7de88db34be403387ece812a377\", \"app_shell_unittests\": \"834d82370940896d8348449693fe0fa2c5d1596d\", \"aura_unittests\": \"15a0a65176891d2796401ceba137d3166e49d97d\", \"base_unittests\": \"6382c2a8a5fd9d6464b5d5858df5871a6bf0e913\", \"base_util_unittests\": \"ff8c374b5e9f550f98fbc5657b9e96eb6e47fb71\", \"blink_common_unittests\": \"87aa13ec26497f7bbd29fb4913799a2480cf9645\", \"blink_fuzzer_unittests\": \"de29129aa7cbdcb7a7ca79510d06b5330ce8ca05\", \"blink_heap_unittests\": \"ed82c4838fedf082f39cc1cecbf683be56ddb7a0\", \"blink_platform_unittests\": \"e191fb34962c77d5c464fba3797492904b4d25ba\", \"blink_python_tests\": \"9a1b1f4a95ce7123ade44bf0eeff5fa622285799\", \"blink_unittests\": \"2c2c6fc51e11154c270f774123a860c033c006c8\", \"blink_web_tests\": \"460cf0a061b08d019d32e0c410de7ecc3e7d7371\", \"boringssl_crypto_tests\": \"6c833f056dd0ddb5ce73be881bfd6adf7059ad27\", \"boringssl_ssl_tests\": \"9801f64dc95eedcf096b5bca3e7deaec96eff989\", \"browser_tests\": \"264a8bcbf35f47bc012bcfd6a63092c997dbd2dd\", \"capture_unittests\": \"6b410a46767e91389602c7bbd64b39fd0651cad3\", \"cast_unittests\": \"e9a56885eb5198c8d2cd65b017ffffca51f0442f\", \"cc_unittests\": \"db06325a32a0fe2b4613e5bec07bcee80ef2622d\", \"chrome_app_unittests\": \"de9473e0d0344a05a48a09d8e09691187de66ca4\", \"chromedriver_unittests\": \"9baa78eb186b327f39382eba4a92bb2ff64054f0\", \"components_browsertests\": \"69d9c4cd0d484a072b563cd1f1679871dba6dbf9\", \"components_unittests\": \"dd2a2a977c0cec11320b06f461abb43ba2846800\", \"compositor_unittests\": \"14910ece9596beac377fbe5df1d4f40f96def4f7\", \"content_browsertests\": \"f8ae97682f23c6a6cff767d6cb46ffe978bf1e01\", \"content_shell_crash_test\": \"0ed4901024139dea2b4462387760f35379a51a05\", \"content_unittests\": \"6fae14639cb46183698c72c71ffb37bbea37c70f\", \"crashpad_tests\": \"800cc320d963d32bc968e502e4138181dbcde2e1\", \"cronet_tests\": \"260fbb4584c7d9affb14dc818c3de482c0e7319e\", \"cronet_unittests\": \"24d34bcb66603a4a3cab52b95ef162749718ca10\", \"crypto_unittests\": \"8ca0f809a1de8100d6681e34fbb82a669dfe17e6\", \"dbus_unittests\": \"b452e909468d11f102a0cd62f81c5a69ee530c9d\", \"device_unittests\": \"d8e8a3e9630619612d6447a0427caed161828c18\", \"display_unittests\": \"843050d83301679a00efdbc5ebfbe43f527185b3\", \"events_unittests\": \"54ddf721a3ebe6e443cf72bdf47304c89d75fefe\", \"extension_docserver_python_unittests\": \"dc469302a00dc8c6f6e578952d1a42988fb333fd\", \"extensions_browsertests\": \"701d44da262509945c928ce9807f486761206ad3\", \"extensions_unittests\": \"552353e77592f75b80ffc154d920028666727825\", \"filesystem_service_unittests\": \"ba36517ef10196f51a6279170bb654e9d068d3c2\", \"flatbuffers_unittests\": \"2420e721089e515c30373ddd4049f833b92985e7\", \"gcm_unit_tests\": \"47c3295ac85be56eed6cabe03bca6d2160fde329\", \"gfx_unittests\": \"ef0c867bfad7ee0e2ea35eb2468dd54379eb0240\", \"gin_unittests\": \"8a4548e0d1c04bbab48e77e987da349b72960701\", \"google_apis_unittests\": \"5be27dbe0dd84b5ea05204291cb29e4a9948935a\", \"gpu_unittests\": \"3f1e5bb252eaa5bbab338c488ac893de459bc12d\", \"grit_python_unittests\": \"5a0f4d5800c5715e1e43400fa407062660e91174\", \"gwp_asan_unittests\": \"e13d1aead43487f8177468c36b3bd343ed69cd2b\", \"headless_browsertests\": \"1293891e585645f99aca4bbb15647267dafbcc72\", \"headless_unittests\": \"86e52694abf830337b3a8ec60e8412aa0913ed22\", \"interactive_ui_tests\": \"add765cc4a1864a074a60446e72056ea98261fa1\", \"ipc_tests\": \"fa040cb11c27987e3e9303520a58a4e773a94553\", \"jingle_unittests\": \"2b734cde44c47b33d8a5e2eab56aa35e536c643f\", \"latency_unittests\": \"05b47b30242e1d7619cdb57286b08d90ad80f6fb\", \"libjingle_xmpp_unittests\": \"35ed2845531c32bc132910f0f20d1aa68b3fb6ad\", \"liburlpattern_unittests\": \"0656a137f75c2e6d9c1679f34234c31795b7a0a4\", \"media_blink_unittests\": \"4a5d9926a841182983410e9989af5c9ed0d3f69d\", \"media_unittests\": \"c09d40e11f1d03bdb56083546e3ffb8a3bb44951\", \"message_center_unittests\": \"0720d3cf23130b35afcf2155412ad92aaa5765d4\", \"metrics_python_tests\": \"d9a7946d06fa196695313720632ad163a100ca02\", \"midi_unittests\": \"8b315c33533ed6825e685d7b0f14ead9dcb52c0e\", \"mojo_core_unittests\": \"e616a45dd64b501029b2df444b4edc87c97eb94f\", \"mojo_unittests\": \"7fbcc0a2d5d92b4d8273cb2966e7761fc8e0636f\", \"nacl_helper_nonsfi_unittests\": \"06490a61259c0cff0317123dc6aa34abb5a247e4\", \"nacl_loader_unittests\": \"41db004bda047023c6b4c9bb5fb7899dd0e2c01a\", \"native_theme_unittests\": \"8698986d9b9c53fb442f79ada284a33df8f6fd31\", \"net_unittests\": \"24bce4a8fe3ce3f7defde883922b6c335c39f9d5\", \"openscreen_unittests\": \"03510c6e31f83fe52a843abfb6a0f8dcd6717dc8\", \"pdf_unittests\": \"03342f12b9209ee1777662bd98a3ec98072db166\", \"perfetto_unittests\": \"07e06f75c9b096ebb2839d69a66ac6cf3cc97046\", \"ppapi_unittests\": \"16a05bb5481d8da61346998164e1dd6df19053b6\", \"printing_unittests\": \"61d0d4caca6d56886cd97497b19b7f5645a487f1\", \"remoting_unittests\": \"86e53bdd097c6c5528b5fcd008fa0309aab4edad\", \"sandbox_linux_unittests\": \"e1ca5b3db8591f7e07941f190b9c962864dc7e38\", \"service_manager_unittests\": \"10a6404212734b40e9f74db97d84ac3bc428daad\", \"services_unittests\": \"85361361bc7211028f03fcac9e40ccd44387894d\", \"shell_dialogs_unittests\": \"580e6f662b785a4701307ef4384ab229c146c324\", \"skia_unittests\": \"5d14cdcc7f0bac31deeb894b2850d93c54ca7544\", \"snapshot_unittests\": \"68ce8cf956b1320a93024b4632bc9cf718269b41\", \"sql_unittests\": \"8ecd188e044063684acc2ea72ffd006c9c7be770\", \"storage_unittests\": \"e6e7a9683d33544a7b4f9299224da2ae87ba3128\", \"sync_integration_tests\": \"fdcec64970a0ab9277be3bff9e904801c406c0d6\", \"telemetry_gpu_unittests\": \"2435d18e9693726b26dc72e3fff61e7c8566557c\", \"telemetry_perf_unittests\": \"7ac591ffcbb41027bd50d61aeb25ab8b1220af96\", \"telemetry_unittests\": \"06e8e92b907d7d052c2c9165e45c4b73fcab7e6e\", \"traffic_annotation_auditor_unittests\": \"efa166444753e92744a1dc7036bef48d17301cd7\", \"ui_base_unittests\": \"a30f814bfd5742addf32c28ac047d2b7d6f5bdab\", \"ui_touch_selection_unittests\": \"bd7d462a48086eb2ade66649ec153330e5a20844\", \"unit_tests\": \"47aaf40d8e9adb159faf81557717cd86c90fd19b\", \"url_unittests\": \"8f3284c2c92315f5e857779a987c18c98545ca43\", \"views_perftests\": \"8cd90a6f8ce6beb6eb0cd7ff8979789ee12f55e2\", \"views_unittests\": \"64237251f49ac15846d52072d671a6ac75b52c8a\", \"viz_unittests\": \"2259b1532c2aadf064ef71f157db17166a74a683\", \"vr_common_unittests\": \"cf2fabfd9734660a7617df79c0ec213a7e7bfc07\", \"vr_pixeltests\": \"2975208f67590035fd5ef9cd5337669bf41bd4c4\", \"webdriver_wpt_tests\": \"74fbdc4fae641a8e73863214bd7fff975c094871\", \"weblayer_browsertests\": \"9da9864353c56376442991af04647421e7350d54\", \"weblayer_unittests\": \"ab34ba9253eb55d788698540248161a6799cb556\", \"wm_unittests\": \"4114877f98321fadcd507048ad7fb5f869187d8c\", \"wtf_unittests\": \"df835b48f393b10c9e1e9fbeaa762e3e1734dbef\", \"x11_unittests\": \"394b4fcd7e199433aa0cf5dd57dccaef4f4e438c\", \"xr_browser_tests\": \"525dc69d1821243b522af47c486f39aa244066b6\", \"zlib_unittests\": \"e45ff30a5f2c41436c844a4c87fa0617a1035fac\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_33498e86c0181efb6d75c3f73059d9522f6d5d2b3b1c7a2dc2a1c6b75cd205cd_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_a3b3a06131dfa9924971b27d0acd4e18e80a2242b6d6ae41f94b770d7c996d6f_v2\", \"builder_e178daccd68499cbb9a2f37c9af80f551f8c5ddb8a7bbdd3e316e81b331c8168_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-86-hldt\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604596746725831",
"status": "COMPLETED",
"status_changed_ts": "1604599735388100",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177391",
"builder:Linux Builder (dbg)",
"buildset:commit/git/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc84917dd7e7b435fce90ddc4b2d61a76279b429",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029882192607952000",
"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/8864452130424319552/+/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:4fb23c0f91290410",
"user_agent:luci-scheduler"
],
"updated_ts": "1604599735393086",
"url": "https://ci.chromium.org/b/8864452130424319552",
"utcnow_ts": "1604599735809104"
}
}
[18:08:55.819] Invocation finished in 50m40.875713269s with status SUCCEEDED