[05:23:03.670] New invocation is queued and will start shortly
[05:23:04.744] Starting the invocation (attempt 1)
[05:23:04.791] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:23:04.791] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:23:04.791] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018693164524525968",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018693164524525968",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"gitiles_ref:refs/heads/master"
]
}
[05:23:05.387] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615267384867299",
"id": "8853263102603930352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615267385247843",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46008",
"builder:linux-chromeos-rel",
"buildset:commit/git/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018693164524525968",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853263102603930352/+/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": "1615267385247959",
"url": "https://ci.chromium.org/b/8853263102603930352",
"utcnow_ts": "1615267385380234"
}
}
[05:23:05.387] Task URL: https://ci.chromium.org/b/8853263102603930352
[05:23:05.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:2:0) after 1m0s
[05:23:09.439] Received PubSub notification, asking Buildbucket for the build status
[05:23:09.519] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:05.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:2:0)
[05:24:05.526] Timer tick, asking Buildbucket for the build status
[05:24:05.671] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:4:0) after 1m0s
[05:25:05.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:4:0)
[05:25:05.754] Timer tick, asking Buildbucket for the build status
[05:25:05.819] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:05.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:5:0) after 1m0s
[05:26:05.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:5:0)
[05:26:05.868] Timer tick, asking Buildbucket for the build status
[05:26:05.951] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:05.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:6:0) after 1m0s
[05:27:06.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:6:0)
[05:27:06.116] Timer tick, asking Buildbucket for the build status
[05:27:06.181] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:7:0) after 1m0s
[05:28:06.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:7:0)
[05:28:06.198] Timer tick, asking Buildbucket for the build status
[05:28:06.362] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:8:0) after 1m0s
[05:29:06.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:8:0)
[05:29:06.420] Timer tick, asking Buildbucket for the build status
[05:29:06.496] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:06.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:9:0) after 1m0s
[05:30:06.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:9:0)
[05:30:06.535] Timer tick, asking Buildbucket for the build status
[05:30:07.784] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:07.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:10:0) after 1m0s
[05:31:07.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:10:0)
[05:31:07.836] Timer tick, asking Buildbucket for the build status
[05:31:08.250] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:08.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:11:0) after 1m0s
[05:32:08.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:11:0)
[05:32:08.492] Timer tick, asking Buildbucket for the build status
[05:32:08.595] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:08.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:12:0) after 1m0s
[05:33:08.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:12:0)
[05:33:08.671] Timer tick, asking Buildbucket for the build status
[05:33:08.791] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:08.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:13:0) after 1m0s
[05:34:08.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:13:0)
[05:34:08.862] Timer tick, asking Buildbucket for the build status
[05:34:08.927] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:08.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:14:0) after 1m0s
[05:35:09.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:14:0)
[05:35:09.002] Timer tick, asking Buildbucket for the build status
[05:35:09.070] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:09.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:15:0) after 1m0s
[05:36:09.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:15:0)
[05:36:09.121] Timer tick, asking Buildbucket for the build status
[05:36:09.197] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:09.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:16:0) after 1m0s
[05:37:09.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:16:0)
[05:37:09.296] Timer tick, asking Buildbucket for the build status
[05:37:09.375] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:09.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:17:0) after 1m0s
[05:38:09.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:17:0)
[05:38:09.405] Timer tick, asking Buildbucket for the build status
[05:38:09.488] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:09.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:18:0) after 1m0s
[05:39:09.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:18:0)
[05:39:09.512] Timer tick, asking Buildbucket for the build status
[05:39:09.573] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:09.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:19:0) after 1m0s
[05:40:09.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:19:0)
[05:40:09.746] Timer tick, asking Buildbucket for the build status
[05:40:09.976] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:09.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:20:0) after 1m0s
[05:41:10.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:20:0)
[05:41:10.021] Timer tick, asking Buildbucket for the build status
[05:41:10.187] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:10.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:21:0) after 1m0s
[05:42:10.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:21:0)
[05:42:10.234] Timer tick, asking Buildbucket for the build status
[05:42:10.436] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:10.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:22:0) after 1m0s
[05:43:10.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:22:0)
[05:43:10.686] Timer tick, asking Buildbucket for the build status
[05:43:10.896] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:10.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:23:0) after 1m0s
[05:44:11.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:23:0)
[05:44:11.114] Timer tick, asking Buildbucket for the build status
[05:44:11.208] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:11.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:24:0) after 1m0s
[05:45:11.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:24:0)
[05:45:11.438] Timer tick, asking Buildbucket for the build status
[05:45:11.625] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:11.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:25:0) after 1m0s
[05:46:11.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:25:0)
[05:46:11.784] Timer tick, asking Buildbucket for the build status
[05:46:11.846] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:11.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:26:0) after 1m0s
[05:47:11.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:26:0)
[05:47:11.960] Timer tick, asking Buildbucket for the build status
[05:47:12.029] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:12.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:27:0) after 1m0s
[05:48:12.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:27:0)
[05:48:12.109] Timer tick, asking Buildbucket for the build status
[05:48:12.451] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:12.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:28:0) after 1m0s
[05:49:12.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:28:0)
[05:49:12.503] Timer tick, asking Buildbucket for the build status
[05:49:12.644] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:12.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:29:0) after 1m0s
[05:50:12.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:29:0)
[05:50:12.812] Timer tick, asking Buildbucket for the build status
[05:50:12.920] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:12.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:30:0) after 1m0s
[05:51:13.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:30:0)
[05:51:13.159] Timer tick, asking Buildbucket for the build status
[05:51:13.279] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:13.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:31:0) after 1m0s
[05:52:14.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:31:0)
[05:52:14.054] Timer tick, asking Buildbucket for the build status
[05:52:14.144] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:14.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:32:0) after 1m0s
[05:53:14.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:32:0)
[05:53:14.255] Timer tick, asking Buildbucket for the build status
[05:53:14.340] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:14.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:33:0) after 1m0s
[05:54:14.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:33:0)
[05:54:14.608] Timer tick, asking Buildbucket for the build status
[05:54:14.681] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:14.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:34:0) after 1m0s
[05:55:14.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:34:0)
[05:55:14.755] Timer tick, asking Buildbucket for the build status
[05:55:14.942] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:14.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:35:0) after 1m0s
[05:56:15.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:35:0)
[05:56:15.061] Timer tick, asking Buildbucket for the build status
[05:56:15.151] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:15.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:36:0) after 1m0s
[05:57:15.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:36:0)
[05:57:15.184] Timer tick, asking Buildbucket for the build status
[05:57:15.255] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:37:0) after 1m0s
[05:58:15.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:37:0)
[05:58:15.414] Timer tick, asking Buildbucket for the build status
[05:58:15.518] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:15.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:38:0) after 1m0s
[05:59:15.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:38:0)
[05:59:15.546] Timer tick, asking Buildbucket for the build status
[05:59:15.674] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:15.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:39:0) after 1m0s
[06:00:15.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:39:0)
[06:00:15.795] Timer tick, asking Buildbucket for the build status
[06:00:16.473] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:16.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:40:0) after 1m0s
[06:01:17.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:40:0)
[06:01:17.663] Timer tick, asking Buildbucket for the build status
[06:01:17.726] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:17.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:41:0) after 1m0s
[06:02:17.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:41:0)
[06:02:17.763] Timer tick, asking Buildbucket for the build status
[06:02:17.866] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:17.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:42:0) after 1m0s
[06:03:17.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:42:0)
[06:03:17.923] Timer tick, asking Buildbucket for the build status
[06:03:18.016] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:18.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:43:0) after 1m0s
[06:04:18.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:43:0)
[06:04:18.128] Timer tick, asking Buildbucket for the build status
[06:04:18.202] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:18.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:44:0) after 1m0s
[06:05:18.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:44:0)
[06:05:18.630] Timer tick, asking Buildbucket for the build status
[06:05:18.696] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:18.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:45:0) after 1m0s
[06:06:18.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:45:0)
[06:06:18.912] Timer tick, asking Buildbucket for the build status
[06:06:19.037] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:19.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:46:0) after 1m0s
[06:07:19.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:46:0)
[06:07:19.193] Timer tick, asking Buildbucket for the build status
[06:07:19.317] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:19.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:47:0) after 1m0s
[06:08:19.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:47:0)
[06:08:19.444] Timer tick, asking Buildbucket for the build status
[06:08:19.652] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:19.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:48:0) after 1m0s
[06:09:19.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:48:0)
[06:09:19.728] Timer tick, asking Buildbucket for the build status
[06:09:19.802] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:19.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:49:0) after 1m0s
[06:10:19.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:49:0)
[06:10:19.878] Timer tick, asking Buildbucket for the build status
[06:10:20.206] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:20.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:50:0) after 1m0s
[06:11:20.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:50:0)
[06:11:20.389] Timer tick, asking Buildbucket for the build status
[06:11:20.774] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:20.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:51:0) after 1m0s
[06:12:20.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:51:0)
[06:12:20.840] Timer tick, asking Buildbucket for the build status
[06:12:21.040] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:21.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:52:0) after 1m0s
[06:13:21.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:52:0)
[06:13:21.181] Timer tick, asking Buildbucket for the build status
[06:13:21.290] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:21.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:53:0) after 1m0s
[06:14:21.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:53:0)
[06:14:21.336] Timer tick, asking Buildbucket for the build status
[06:14:21.499] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:21.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:54:0) after 1m0s
[06:15:21.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:54:0)
[06:15:21.591] Timer tick, asking Buildbucket for the build status
[06:15:21.933] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:21.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:55:0) after 1m0s
[06:16:22.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:55:0)
[06:16:22.102] Timer tick, asking Buildbucket for the build status
[06:16:22.309] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:22.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:56:0) after 1m0s
[06:17:22.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:56:0)
[06:17:22.830] Timer tick, asking Buildbucket for the build status
[06:17:22.924] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:22.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:57:0) after 1m0s
[06:18:23.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:57:0)
[06:18:23.091] Timer tick, asking Buildbucket for the build status
[06:18:23.412] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:23.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:58:0) after 1m0s
[06:19:23.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:58:0)
[06:19:23.492] Timer tick, asking Buildbucket for the build status
[06:19:23.643] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:23.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:59:0) after 1m0s
[06:20:23.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:59:0)
[06:20:23.643] Timer tick, asking Buildbucket for the build status
[06:20:23.720] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:23.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:60:0) after 1m0s
[06:21:23.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:60:0)
[06:21:23.767] Timer tick, asking Buildbucket for the build status
[06:21:23.963] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:23.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:61:0) after 1m0s
[06:22:23.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:61:0)
[06:22:23.990] Timer tick, asking Buildbucket for the build status
[06:22:24.070] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:24.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:62:0) after 1m0s
[06:23:24.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:62:0)
[06:23:24.086] Timer tick, asking Buildbucket for the build status
[06:23:24.446] Build 8853263102603930352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018693164524525968:63:0) after 1m0s
[06:24:04.690] Received PubSub notification, asking Buildbucket for the build status
[06:24:04.777] Build 8853263102603930352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:24:04.777] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615271043611752",
"created_by": "project:chromium",
"created_ts": "1615267384867299",
"id": "8853263102603930352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\", \"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-east1-d-8-100-hxnc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46008, \"got_angle_revision\": \"92049513f46e2d4bc09d47d00f63d64fdb25a220\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\", \"got_revision_cp\": \"refs/heads/master@{#861036}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"5c86b9ed5fdab5a53c326ae37b77effcef0b67ff\", \"got_v8_revision_cp\": \"refs/heads/9.1.75@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89\", \"swarm_hashes_refs/heads/master(at){#861036}_without_patch\": {\"absl_hardening_tests\": \"a426d3dad0489b7749b5b1e73d5fe5f5eb95ae17\", \"accessibility_unittests\": \"cb60ace05cff2fb22c5bb2b8aac5086f9b7c9d3c\", \"angle_unittests\": \"5f48dca856fc8e009e563ec5f0e4c2312cf80cd3\", \"app_list_unittests\": \"8edc0d1652b88f44aedbc770cba4aac3c22e6528\", \"app_shell_unittests\": \"97bace56e78e334e27be637147eb298934c07569\", \"ash_unittests\": \"0aa5c99b69313f469a7810d2a4efff8e06e24c7d\", \"aura_unittests\": \"fe3896d6cd1b07b3f478cbe620da0467c5297bf2\", \"base_unittests\": \"f62bc3b2231f9639e6ac34369699163dc1cf94be\", \"base_util_unittests\": \"4d647b2e9a1abd21f6ff6e19193ce51daf7f4b71\", \"blink_common_unittests\": \"0d3e0adbd5ddbab29bc6fb2d8696929e5ccddc29\", \"blink_fuzzer_unittests\": \"8a1696404e204f4c36899840e03fd370b635c1e1\", \"blink_heap_unittests\": \"036c8f24917b566a3a2e171c929a61ca5fa7ad27\", \"blink_platform_unittests\": \"2ba126d200893a7320d89a13c5c1b22b173f43bc\", \"blink_unittests\": \"e8b436db8e158e3ec27d47be95bc45ac3964464b\", \"boringssl_crypto_tests\": \"7908def0c33e395a093cff246a68e9129008bfed\", \"boringssl_ssl_tests\": \"e09d91555a6e82c812eb2826e970c37faeed8072\", \"browser_tests\": \"06632905fac09505b2f0f3b15925b2e79dc562e5\", \"capture_unittests\": \"63cffe102ea6dec5559f54604da2ff44990fcdcb\", \"cast_unittests\": \"e2ef95acc37d3023a81a96fc22bb3d1c74b5bb2c\", \"cc_unittests\": \"976f5a091336ed51784d582d4dbd0c82ce4bdd99\", \"chrome_app_unittests\": \"3602cd6d8c5558537135c7ab2eacdd42946a2c41\", \"chromedriver_unittests\": \"501579b1b0c6a551b09262c6bef7d52658c331e4\", \"chromeos_components_unittests\": \"093917ba7df5906c1900bacf306f7c5bcda7495e\", \"chromeos_unittests\": \"d6d9bfbdbb6c5e774e3389c717fa10212c839e80\", \"color_unittests\": \"5dff34833c5a055061d3780fe181b0f465a91134\", \"components_browsertests\": \"0773b01094f891080edfe227bef2251d55757f86\", \"components_unittests\": \"e670b47f879f7315366d5883b55b236e2baa698e\", \"compositor_unittests\": \"9d91049f9be691d3967b95593050b57ca104368e\", \"content_browsertests\": \"353cf98312ea81ce5094d191e2060a696383cc2b\", \"content_unittests\": \"88c14084910db2ec2472414fba0589a9e9f3b928\", \"crashpad_tests\": \"105dafb00c47f3b46430157036816f9b06565acf\", \"crypto_unittests\": \"b4612e11a749cdf60f0bee2c8ac4ae03fc1e6275\", \"dbus_unittests\": \"a2d1b007add9dfd546baea92fc1ca032ad781ff8\", \"device_unittests\": \"95eaf990a12b8772bf852cd2bfaf62c02029b4bb\", \"display_unittests\": \"439a6d14c0887a61137b7e139fed68ea66d47d86\", \"events_unittests\": \"11d83607fbd00a1ecfa5c29c3c81d65a462dc9bb\", \"exo_unittests\": \"4c6d7b44d59a0046ec1d6c2ec2063abc59cced24\", \"extensions_browsertests\": \"ff1bb50ab076156a9e7f6246e1c417dfcf8a5341\", \"extensions_unittests\": \"268cd983f084dcd99933b50f4948236d43af68c3\", \"filesystem_service_unittests\": \"0c3d5a4d1159c5b446a9fe73861e2addbd37f909\", \"gcm_unit_tests\": \"a204d98ff2188f748d04135679d53c2bd5f7fe6d\", \"gfx_unittests\": \"2128f6a05053fe6a6e553805f55537f0aca2b34e\", \"gin_unittests\": \"c76c2bd90010fcc5b9e4e7bf30c3414d28d79d7f\", \"gl_unittests_ozone\": \"717cf9fd018fd32d3021ebd3a2b54782b967e1f6\", \"google_apis_unittests\": \"1b3eff35d8b81e183aff971907aae71e4e120c5f\", \"gpu_unittests\": \"340c9619866decb88a4ec463c6ab36784186411c\", \"gwp_asan_unittests\": \"d55b4d3650097a2f31537bf2d1b933fad8f7f160\", \"interactive_ui_tests\": \"1f9ae8130471b0044b9c58c56b605ca52f3f97fb\", \"ipc_tests\": \"64bf41ee1d19633e100daa893484cf879d436d20\", \"jingle_unittests\": \"98a1436d6c3602c84ca6b462b7b4c93aebfd6525\", \"keyboard_unittests\": \"40b4556543c9d513fd6da926aa0cd5127a7987ac\", \"latency_unittests\": \"c1f02579c1ead46292961dadb5e4c823e86e8499\", \"libjingle_xmpp_unittests\": \"4dd349f75234e1cb9ff9e1d788f9c4a7c4cbde07\", \"liburlpattern_unittests\": \"bd445752c3d879ed5d3fd8909f59fb7f01383efa\", \"media_blink_unittests\": \"9862609e42a7bcdce88617e0a4cf2a06498a3b1c\", \"media_unittests\": \"0768a66aee521eafac9d99534946a43a4ffae7bc\", \"message_center_unittests\": \"50bbd07fe42fc9a25dc972d17bcee4fc284b50b2\", \"midi_unittests\": \"2a50ec2c47f3484c17583d558c0b6f45e2a62b59\", \"mojo_core_unittests\": \"17c684c4c837e19957047e4534c6bf0a8ec6d53f\", \"mojo_unittests\": \"704995716cdf2d391cf469cf11b0c326c7fa7bdd\", \"nacl_helper_nonsfi_unittests\": \"952b203294fc7b11b95ea8e47345eefc8d0b4ae1\", \"nacl_loader_unittests\": \"f736351fb253c5d93a41720dfdfb02a6fbaf5535\", \"native_theme_unittests\": \"8b18afc82ebf1ff5e568edd67e172f30b0527ee2\", \"net_unittests\": \"8c722fcfbdbf81fcd4f00e5bd338002f6a3bb75c\", \"ozone_gl_unittests\": \"5445a2ee64ddecb9186a422862f52ba99fc54af4\", \"ozone_unittests\": \"af54badbb6d553acad75a4b04df8f113e1da7d1c\", \"ozone_x11_unittests\": \"50800bc220b4c14a431a5b32ca1d13b67cf6dd9e\", \"pdf_unittests\": \"fdd60e1d938bab496cf2ef6164b49bd3943aff41\", \"perfetto_unittests\": \"54f976f219440d420815bc5faa2f6d7aa9381417\", \"ppapi_unittests\": \"f6567de3d93a508c63710f3f2a7dd8f055e0b31f\", \"printing_unittests\": \"d09a2820dbe37ff33a7d30877997361f7ec2b52b\", \"remoting_unittests\": \"1fa65b2fa1f84370707d1e9898c1839c5097c12e\", \"sandbox_linux_unittests\": \"612b1e1cc4d22154dd1ffb53715807ae958e180d\", \"service_manager_unittests\": \"4e080bcbd3e877c5092edfb749617dc7addb9fbc\", \"services_unittests\": \"9d72c9643d45baa4ff4426ddc4e594b32d218580\", \"shell_dialogs_unittests\": \"fb4426dcc9c848aa6d87fcd4827fbea2acc470f1\", \"shell_encryption_unittests\": \"c4e99d64abb88c4e96667f93d1a6dbeae9cdf2c6\", \"skia_unittests\": \"47fc3f507bc8f18861e12d01f957cb050e2f1e2e\", \"snapshot_unittests\": \"7e25203aafe904e9eb327f6899e801462eec8832\", \"sql_unittests\": \"3bc9e038b7e31cd1e2baff5ab0db8d7d49c845b0\", \"storage_unittests\": \"89b027510e94f1627430f977a7b129937db2bba1\", \"sync_integration_tests\": \"ef899132373e693872ee8486adf9e28435cb02f2\", \"traffic_annotation_auditor_unittests\": \"7d3f1340ee5ecc9de574d300cd22fd99c6afb135\", \"ui_base_unittests\": \"1f30ac0f0b0c5c419d7196c2139b306dd0f741db\", \"ui_chromeos_unittests\": \"aacfe64751ad72dc8915694c23a1295193219737\", \"ui_touch_selection_unittests\": \"7eb57c4fd0eb5946111f840ae51d59b42c13c854\", \"unit_tests\": \"de0e5d5d98b53405adff667ee3f3437a95079c70\", \"url_unittests\": \"b7adb38a130039bed7a2832701aab4e23b45f427\", \"usage_time_limit_unittests\": \"ec929d31f13cc45015d3fe590e318e7ca9516493\", \"views_unittests\": \"a0b91c4218b41d4ccf6d90d528ee367f4ae73dd8\", \"viz_unittests\": \"70f452c23334efe32017800a0e2e55906bd7747b\", \"wayland_client_perftests\": \"cf6898dc3110dba16bcb4f87616eb27015929a78\", \"wayland_client_tests\": \"cfeeef46676c94ca8b95f6c5a6c1788ec6cee194\", \"wm_unittests\": \"35ebdec94bb02acff7d7ec680bb03bb74e597e38\", \"wtf_unittests\": \"bfc400828e7241084f1b18a2eaae319797e9262b\", \"zlib_unittests\": \"31b75eef06b6cd0d98d378059a25f2ca89bf60fb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2855e992f831a6f83aeb6af37408c7fe8049cd437e9a77110d5865b36b77c9b8_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_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-east1-d-8-100-hxnc\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615267388598268",
"status": "COMPLETED",
"status_changed_ts": "1615271044072131",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46008",
"builder:linux-chromeos-rel",
"buildset:commit/git/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d94aa1e533f1aac9380e5ced4e8dc36e0a8abe89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018693164524525968",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853263102603930352/+/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:522e41d8c9e2c810",
"user_agent:luci-scheduler"
],
"updated_ts": "1615271044104749",
"url": "https://ci.chromium.org/b/8853263102603930352",
"utcnow_ts": "1615271044766686"
}
}
[06:24:04.777] Invocation finished in 1h1m1.124908197s with status SUCCEEDED