[06:24:06.805] New invocation is queued and will start shortly
[06:24:08.077] Starting the invocation (attempt 1)
[06:24:08.107] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:24:08.107] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:24:08.107] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018689323444785296",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"41d37b70456754e670c6441117e2377f38bc263f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018689323444785296",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/41d37b70456754e670c6441117e2377f38bc263f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41d37b70456754e670c6441117e2377f38bc263f",
"gitiles_ref:refs/heads/master"
]
}
[06:24:09.233] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615271048253785",
"id": "8853259261264834480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41d37b70456754e670c6441117e2377f38bc263f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615271049054762",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46009",
"builder:linux-chromeos-rel",
"buildset:commit/git/41d37b70456754e670c6441117e2377f38bc263f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41d37b70456754e670c6441117e2377f38bc263f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018689323444785296",
"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/8853259261264834480/+/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": "1615271049054919",
"url": "https://ci.chromium.org/b/8853259261264834480",
"utcnow_ts": "1615271049222875"
}
}
[06:24:09.233] Task URL: https://ci.chromium.org/b/8853259261264834480
[06:24:09.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:2:0) after 1m0s
[06:24:46.389] Received PubSub notification, asking Buildbucket for the build status
[06:24:46.449] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:09.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:2:0)
[06:25:09.256] Timer tick, asking Buildbucket for the build status
[06:25:09.331] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:09.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:4:0) after 1m0s
[06:26:09.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:4:0)
[06:26:09.362] Timer tick, asking Buildbucket for the build status
[06:26:09.426] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:09.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:5:0) after 1m0s
[06:27:09.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:5:0)
[06:27:09.443] Timer tick, asking Buildbucket for the build status
[06:27:09.525] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:09.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:6:0) after 1m0s
[06:28:09.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:6:0)
[06:28:09.565] Timer tick, asking Buildbucket for the build status
[06:28:09.629] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:09.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:7:0) after 1m0s
[06:29:09.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:7:0)
[06:29:09.656] Timer tick, asking Buildbucket for the build status
[06:29:09.728] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:09.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:8:0) after 1m0s
[06:30:09.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:8:0)
[06:30:09.820] Timer tick, asking Buildbucket for the build status
[06:30:10.212] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:10.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:9:0) after 1m0s
[06:31:10.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:9:0)
[06:31:10.262] Timer tick, asking Buildbucket for the build status
[06:31:10.327] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:10.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:10:0) after 1m0s
[06:32:10.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:10:0)
[06:32:10.405] Timer tick, asking Buildbucket for the build status
[06:32:10.674] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:10.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:11:0) after 1m0s
[06:33:10.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:11:0)
[06:33:10.717] Timer tick, asking Buildbucket for the build status
[06:33:10.915] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:10.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:12:0) after 1m0s
[06:34:10.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:12:0)
[06:34:10.929] Timer tick, asking Buildbucket for the build status
[06:34:11.109] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:11.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:13:0) after 1m0s
[06:35:11.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:13:0)
[06:35:11.114] Timer tick, asking Buildbucket for the build status
[06:35:11.196] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:11.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:14:0) after 1m0s
[06:36:11.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:14:0)
[06:36:11.184] Timer tick, asking Buildbucket for the build status
[06:36:11.252] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:11.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:15:0) after 1m0s
[06:37:11.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:15:0)
[06:37:11.265] Timer tick, asking Buildbucket for the build status
[06:37:11.371] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:11.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:16:0) after 1m0s
[06:38:11.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:16:0)
[06:38:11.386] Timer tick, asking Buildbucket for the build status
[06:38:11.472] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:11.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:17:0) after 1m0s
[06:39:11.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:17:0)
[06:39:11.501] Timer tick, asking Buildbucket for the build status
[06:39:11.586] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:11.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:18:0) after 1m0s
[06:40:11.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:18:0)
[06:40:11.600] Timer tick, asking Buildbucket for the build status
[06:40:11.670] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:11.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:19:0) after 1m0s
[06:41:11.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:19:0)
[06:41:11.728] Timer tick, asking Buildbucket for the build status
[06:41:11.819] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:11.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:20:0) after 1m0s
[06:42:11.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:20:0)
[06:42:11.921] Timer tick, asking Buildbucket for the build status
[06:42:11.986] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:11.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:21:0) after 1m0s
[06:43:12.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:21:0)
[06:43:12.077] Timer tick, asking Buildbucket for the build status
[06:43:12.148] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:12.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:22:0) after 1m0s
[06:44:12.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:22:0)
[06:44:12.524] Timer tick, asking Buildbucket for the build status
[06:44:12.701] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:12.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:23:0) after 1m0s
[06:45:13.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:23:0)
[06:45:13.155] Timer tick, asking Buildbucket for the build status
[06:45:13.227] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:13.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:24:0) after 1m0s
[06:46:13.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:24:0)
[06:46:13.257] Timer tick, asking Buildbucket for the build status
[06:46:13.323] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:13.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:25:0) after 1m0s
[06:47:13.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:25:0)
[06:47:13.342] Timer tick, asking Buildbucket for the build status
[06:47:14.616] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:14.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:26:0) after 1m0s
[06:48:14.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:26:0)
[06:48:14.705] Timer tick, asking Buildbucket for the build status
[06:48:14.785] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:14.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:27:0) after 1m0s
[06:49:14.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:27:0)
[06:49:14.819] Timer tick, asking Buildbucket for the build status
[06:49:14.896] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:14.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:28:0) after 1m0s
[06:50:14.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:28:0)
[06:50:14.960] Timer tick, asking Buildbucket for the build status
[06:50:15.033] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:15.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:29:0) after 1m0s
[06:51:15.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:29:0)
[06:51:15.083] Timer tick, asking Buildbucket for the build status
[06:51:15.431] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:15.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:30:0) after 1m0s
[06:52:15.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:30:0)
[06:52:15.456] Timer tick, asking Buildbucket for the build status
[06:52:15.523] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:15.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:31:0) after 1m0s
[06:53:15.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:31:0)
[06:53:15.544] Timer tick, asking Buildbucket for the build status
[06:53:15.720] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:15.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:32:0) after 1m0s
[06:54:16.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:32:0)
[06:54:16.264] Timer tick, asking Buildbucket for the build status
[06:54:16.336] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:16.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:33:0) after 1m0s
[06:55:16.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:33:0)
[06:55:16.390] Timer tick, asking Buildbucket for the build status
[06:55:16.723] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:16.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:34:0) after 1m0s
[06:56:16.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:34:0)
[06:56:16.831] Timer tick, asking Buildbucket for the build status
[06:56:16.907] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:16.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:35:0) after 1m0s
[06:57:17.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:35:0)
[06:57:17.099] Timer tick, asking Buildbucket for the build status
[06:57:17.462] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:17.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:36:0) after 1m0s
[06:58:17.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:36:0)
[06:58:17.775] Timer tick, asking Buildbucket for the build status
[06:58:17.847] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:17.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:37:0) after 1m0s
[06:59:17.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:37:0)
[06:59:17.973] Timer tick, asking Buildbucket for the build status
[06:59:18.125] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:18.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:38:0) after 1m0s
[07:00:18.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:38:0)
[07:00:18.177] Timer tick, asking Buildbucket for the build status
[07:00:18.434] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:18.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:39:0) after 1m0s
[07:01:18.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:39:0)
[07:01:18.479] Timer tick, asking Buildbucket for the build status
[07:01:18.559] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:18.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:40:0) after 1m0s
[07:02:18.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:40:0)
[07:02:18.610] Timer tick, asking Buildbucket for the build status
[07:02:18.768] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:18.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:41:0) after 1m0s
[07:03:18.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:41:0)
[07:03:18.785] Timer tick, asking Buildbucket for the build status
[07:03:18.914] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:18.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:42:0) after 1m0s
[07:04:18.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:42:0)
[07:04:18.973] Timer tick, asking Buildbucket for the build status
[07:04:19.333] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:19.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:43:0) after 1m0s
[07:05:19.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:43:0)
[07:05:19.356] Timer tick, asking Buildbucket for the build status
[07:05:20.340] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:44:0) after 1m0s
[07:06:20.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:44:0)
[07:06:20.338] Timer tick, asking Buildbucket for the build status
[07:06:20.446] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:20.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:45:0) after 1m0s
[07:07:20.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:45:0)
[07:07:20.613] Timer tick, asking Buildbucket for the build status
[07:07:20.683] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:20.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:46:0) after 1m0s
[07:08:20.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:46:0)
[07:08:20.849] Timer tick, asking Buildbucket for the build status
[07:08:20.937] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:20.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:47:0) after 1m0s
[07:09:21.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:47:0)
[07:09:21.224] Timer tick, asking Buildbucket for the build status
[07:09:21.343] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:21.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:48:0) after 1m0s
[07:10:21.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:48:0)
[07:10:21.436] Timer tick, asking Buildbucket for the build status
[07:10:21.575] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:21.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:49:0) after 1m0s
[07:11:21.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:49:0)
[07:11:21.625] Timer tick, asking Buildbucket for the build status
[07:11:21.737] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:21.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:50:0) after 1m0s
[07:12:21.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:50:0)
[07:12:21.779] Timer tick, asking Buildbucket for the build status
[07:12:22.462] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:22.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:51:0) after 1m0s
[07:13:22.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:51:0)
[07:13:22.564] Timer tick, asking Buildbucket for the build status
[07:13:22.649] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:22.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:52:0) after 1m0s
[07:14:22.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:52:0)
[07:14:22.645] Timer tick, asking Buildbucket for the build status
[07:14:22.765] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:22.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:53:0) after 1m0s
[07:15:22.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:53:0)
[07:15:22.793] Timer tick, asking Buildbucket for the build status
[07:15:22.881] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:22.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:54:0) after 1m0s
[07:16:23.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:54:0)
[07:16:23.235] Timer tick, asking Buildbucket for the build status
[07:16:23.449] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:23.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:55:0) after 1m0s
[07:17:23.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:55:0)
[07:17:23.507] Timer tick, asking Buildbucket for the build status
[07:17:23.736] Build 8853259261264834480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:23.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018689323444785296:56:0) after 1m0s
[07:17:42.097] Received PubSub notification, asking Buildbucket for the build status
[07:17:42.256] Build 8853259261264834480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:17:42.257] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615274261210729",
"created_by": "project:chromium",
"created_ts": "1615271048253785",
"id": "8853259261264834480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41d37b70456754e670c6441117e2377f38bc263f\"}}",
"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\": \"41d37b70456754e670c6441117e2377f38bc263f\", \"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\": 46009, \"got_angle_revision\": \"92049513f46e2d4bc09d47d00f63d64fdb25a220\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"41d37b70456754e670c6441117e2377f38bc263f\", \"got_revision_cp\": \"refs/heads/master@{#861047}\", \"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\": \"41d37b70456754e670c6441117e2377f38bc263f\", \"swarm_hashes_refs/heads/master(at){#861047}_without_patch\": {\"absl_hardening_tests\": \"a426d3dad0489b7749b5b1e73d5fe5f5eb95ae17\", \"accessibility_unittests\": \"cb60ace05cff2fb22c5bb2b8aac5086f9b7c9d3c\", \"angle_unittests\": \"5f48dca856fc8e009e563ec5f0e4c2312cf80cd3\", \"app_list_unittests\": \"6384e0b2617910b4ec622279763951298114639d\", \"app_shell_unittests\": \"4f195c62b96f4e252bff96d357589b45527eda7d\", \"ash_unittests\": \"6c47aefac69f0048e6e15ddc09afcea50f38e67d\", \"aura_unittests\": \"fe3896d6cd1b07b3f478cbe620da0467c5297bf2\", \"base_unittests\": \"cb44ba42ade5c8047462b1c6b08e7fa915d1a803\", \"base_util_unittests\": \"4d647b2e9a1abd21f6ff6e19193ce51daf7f4b71\", \"blink_common_unittests\": \"0d3e0adbd5ddbab29bc6fb2d8696929e5ccddc29\", \"blink_fuzzer_unittests\": \"8a1696404e204f4c36899840e03fd370b635c1e1\", \"blink_heap_unittests\": \"036c8f24917b566a3a2e171c929a61ca5fa7ad27\", \"blink_platform_unittests\": \"8dfd24fc81160e18dab665717d2688b128e99656\", \"blink_unittests\": \"5809ac48f64cc175e2e7429f6888afe8936245aa\", \"boringssl_crypto_tests\": \"7908def0c33e395a093cff246a68e9129008bfed\", \"boringssl_ssl_tests\": \"e09d91555a6e82c812eb2826e970c37faeed8072\", \"browser_tests\": \"4489aeaab57df4e42ceceae9d44c978fb519f6b0\", \"capture_unittests\": \"63cffe102ea6dec5559f54604da2ff44990fcdcb\", \"cast_unittests\": \"e2ef95acc37d3023a81a96fc22bb3d1c74b5bb2c\", \"cc_unittests\": \"976f5a091336ed51784d582d4dbd0c82ce4bdd99\", \"chrome_app_unittests\": \"eb1476a9b103b252e09eb9200eb93b846ec66066\", \"chromedriver_unittests\": \"3ffcd9de42690652ce129f227c8f3f6ce931f0d0\", \"chromeos_components_unittests\": \"7529ba263b5870927bb2f9a30c206af0d3cd7108\", \"chromeos_unittests\": \"d6d9bfbdbb6c5e774e3389c717fa10212c839e80\", \"color_unittests\": \"5dff34833c5a055061d3780fe181b0f465a91134\", \"components_browsertests\": \"5e5d1660cceb0c9634ed4cfae498c484a3d69977\", \"components_unittests\": \"8a228e7f510a0e515b4807d8f75163b13e8f7e1e\", \"compositor_unittests\": \"9d91049f9be691d3967b95593050b57ca104368e\", \"content_browsertests\": \"dea527555a790b369aca685e54be5ed2572cbbec\", \"content_unittests\": \"e5b4ee15dedfb756b9864f809ba4f0510e277f77\", \"crashpad_tests\": \"105dafb00c47f3b46430157036816f9b06565acf\", \"crypto_unittests\": \"b4612e11a749cdf60f0bee2c8ac4ae03fc1e6275\", \"dbus_unittests\": \"a2d1b007add9dfd546baea92fc1ca032ad781ff8\", \"device_unittests\": \"2c44911eed9cb5e6b8d85e376d15d77720e4bf20\", \"display_unittests\": \"439a6d14c0887a61137b7e139fed68ea66d47d86\", \"events_unittests\": \"11d83607fbd00a1ecfa5c29c3c81d65a462dc9bb\", \"exo_unittests\": \"db666e725bf281681e0766610f909aac5e8508ad\", \"extensions_browsertests\": \"fa443247ced5bce28fa8e10fef0012963b4b9f38\", \"extensions_unittests\": \"26569f1476d2c372c863bf03281374e3e70dac63\", \"filesystem_service_unittests\": \"0c3d5a4d1159c5b446a9fe73861e2addbd37f909\", \"gcm_unit_tests\": \"0b8e1427e73ed921639f9b385926922f0dd4021f\", \"gfx_unittests\": \"d039d801c05c65afb9bdcb62f79869f17274f9be\", \"gin_unittests\": \"c76c2bd90010fcc5b9e4e7bf30c3414d28d79d7f\", \"gl_unittests_ozone\": \"717cf9fd018fd32d3021ebd3a2b54782b967e1f6\", \"google_apis_unittests\": \"b8760545fc5fa97092843dd8b92723137f6de3c3\", \"gpu_unittests\": \"340c9619866decb88a4ec463c6ab36784186411c\", \"gwp_asan_unittests\": \"d55b4d3650097a2f31537bf2d1b933fad8f7f160\", \"interactive_ui_tests\": \"ca4c3be2bd03a340c983bf97b51fc90cc7ee28ac\", \"ipc_tests\": \"64bf41ee1d19633e100daa893484cf879d436d20\", \"jingle_unittests\": \"d4ce4df942663a0138b2322b5e76537c4c58e0a8\", \"keyboard_unittests\": \"412994a73656de934874a02c5100f410d6d0762b\", \"latency_unittests\": \"c1f02579c1ead46292961dadb5e4c823e86e8499\", \"libjingle_xmpp_unittests\": \"4dd349f75234e1cb9ff9e1d788f9c4a7c4cbde07\", \"liburlpattern_unittests\": \"bd445752c3d879ed5d3fd8909f59fb7f01383efa\", \"media_blink_unittests\": \"70627c175a4aa7a3e61bd32a4b7ed46751a84afe\", \"media_unittests\": \"0768a66aee521eafac9d99534946a43a4ffae7bc\", \"message_center_unittests\": \"19c393fa2d8cadde8cc32737ee7366c7b34b786a\", \"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\": \"488cec6316b4ac3857e58bb8d8072610de7176ae\", \"sandbox_linux_unittests\": \"612b1e1cc4d22154dd1ffb53715807ae958e180d\", \"service_manager_unittests\": \"4e080bcbd3e877c5092edfb749617dc7addb9fbc\", \"services_unittests\": \"f9af36a80c001dc9b6ca51582a9055bf77087006\", \"shell_dialogs_unittests\": \"ad198caeb4054f2f169f65223c8a662c49b46869\", \"shell_encryption_unittests\": \"c4e99d64abb88c4e96667f93d1a6dbeae9cdf2c6\", \"skia_unittests\": \"47fc3f507bc8f18861e12d01f957cb050e2f1e2e\", \"snapshot_unittests\": \"7e25203aafe904e9eb327f6899e801462eec8832\", \"sql_unittests\": \"3bc9e038b7e31cd1e2baff5ab0db8d7d49c845b0\", \"storage_unittests\": \"89b027510e94f1627430f977a7b129937db2bba1\", \"sync_integration_tests\": \"80e9fe42e66e866d95a6db0c2fb3dca6b05af1e7\", \"traffic_annotation_auditor_unittests\": \"7d3f1340ee5ecc9de574d300cd22fd99c6afb135\", \"ui_base_unittests\": \"b795de3315a400333fabfb6840b950fff55ff2d5\", \"ui_chromeos_unittests\": \"4b7303cd5bc15a1fa7e7e86edad9e5d7aadcb107\", \"ui_touch_selection_unittests\": \"7eb57c4fd0eb5946111f840ae51d59b42c13c854\", \"unit_tests\": \"80426093047ea865a0fd2fcef95ab7c3f1ce8010\", \"url_unittests\": \"b7adb38a130039bed7a2832701aab4e23b45f427\", \"usage_time_limit_unittests\": \"ec929d31f13cc45015d3fe590e318e7ca9516493\", \"views_unittests\": \"0a5e50e8bff246e1db9ab8eb0aca18b697aa9c98\", \"viz_unittests\": \"70f452c23334efe32017800a0e2e55906bd7747b\", \"wayland_client_perftests\": \"3a33fe0146500048de16c67915773cc86e8d7430\", \"wayland_client_tests\": \"2142ccf8368f19063093c3486a561e2986cefa53\", \"wm_unittests\": \"d003a93f3b64c79efc5b97e6d827c07e8ce3dc77\", \"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": "1615271084660950",
"status": "COMPLETED",
"status_changed_ts": "1615274261543586",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46009",
"builder:linux-chromeos-rel",
"buildset:commit/git/41d37b70456754e670c6441117e2377f38bc263f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41d37b70456754e670c6441117e2377f38bc263f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018689323444785296",
"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/8853259261264834480/+/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:522e79c053a69a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615274261551794",
"url": "https://ci.chromium.org/b/8853259261264834480",
"utcnow_ts": "1615274262244225"
}
}
[07:17:42.257] Invocation finished in 53m35.46554575s with status SUCCEEDED