[23:33:58.752] New invocation is queued and will start shortly
[23:34:00.008] Starting the invocation (attempt 1)
[23:34:00.047] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:34:00.047] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:34:00.047] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020617663155102576",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e897d7f2a0085f08bc3801753f5be47aae8c03e4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020617663155102576",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"gitiles_ref:refs/heads/master"
]
}
[23:34:01.501] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613432040256264",
"id": "8855187600914323600",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e897d7f2a0085f08bc3801753f5be47aae8c03e4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613432041155975",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45438",
"builder:linux-chromeos-rel",
"buildset:commit/git/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020617663155102576",
"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/8855187600914323600/+/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": "1613432041156090",
"url": "https://ci.chromium.org/b/8855187600914323600",
"utcnow_ts": "1613432041491129"
}
}
[23:34:01.501] Task URL: https://ci.chromium.org/b/8855187600914323600
[23:34:01.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:2:0) after 1m0s
[23:34:43.800] Received PubSub notification, asking Buildbucket for the build status
[23:34:43.902] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:03.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:2:0)
[23:35:03.439] Timer tick, asking Buildbucket for the build status
[23:35:03.554] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:03.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:4:0) after 1m0s
[23:36:03.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:4:0)
[23:36:03.570] Timer tick, asking Buildbucket for the build status
[23:36:03.651] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:03.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:5:0) after 1m0s
[23:37:03.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:5:0)
[23:37:03.714] Timer tick, asking Buildbucket for the build status
[23:37:03.781] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:03.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:6:0) after 1m0s
[23:38:03.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:6:0)
[23:38:03.806] Timer tick, asking Buildbucket for the build status
[23:38:04.011] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:04.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:7:0) after 1m0s
[23:39:04.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:7:0)
[23:39:04.119] Timer tick, asking Buildbucket for the build status
[23:39:04.241] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:04.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:8:0) after 1m0s
[23:40:04.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:8:0)
[23:40:04.293] Timer tick, asking Buildbucket for the build status
[23:40:04.763] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:04.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:9:0) after 1m0s
[23:41:04.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:9:0)
[23:41:04.955] Timer tick, asking Buildbucket for the build status
[23:41:05.203] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:05.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:10:0) after 1m0s
[23:42:05.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:10:0)
[23:42:05.443] Timer tick, asking Buildbucket for the build status
[23:42:05.521] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:05.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:11:0) after 1m0s
[23:43:05.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:11:0)
[23:43:05.647] Timer tick, asking Buildbucket for the build status
[23:43:05.756] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:05.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:12:0) after 1m0s
[23:44:05.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:12:0)
[23:44:05.999] Timer tick, asking Buildbucket for the build status
[23:44:06.122] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:06.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:13:0) after 1m0s
[23:45:06.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:13:0)
[23:45:06.142] Timer tick, asking Buildbucket for the build status
[23:45:06.248] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:06.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:14:0) after 1m0s
[23:46:06.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:14:0)
[23:46:06.312] Timer tick, asking Buildbucket for the build status
[23:46:06.492] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:06.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:15:0) after 1m0s
[23:47:06.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:15:0)
[23:47:06.512] Timer tick, asking Buildbucket for the build status
[23:47:06.805] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:06.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:16:0) after 1m0s
[23:48:06.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:16:0)
[23:48:06.865] Timer tick, asking Buildbucket for the build status
[23:48:06.938] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:06.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:17:0) after 1m0s
[23:49:06.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:17:0)
[23:49:06.956] Timer tick, asking Buildbucket for the build status
[23:49:07.059] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:07.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:18:0) after 1m0s
[23:50:07.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:18:0)
[23:50:07.126] Timer tick, asking Buildbucket for the build status
[23:50:07.541] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:07.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:19:0) after 1m0s
[23:51:07.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:19:0)
[23:51:07.586] Timer tick, asking Buildbucket for the build status
[23:51:07.700] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:07.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:20:0) after 1m0s
[23:52:07.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:20:0)
[23:52:07.794] Timer tick, asking Buildbucket for the build status
[23:52:07.876] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:07.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:21:0) after 1m0s
[23:53:07.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:21:0)
[23:53:07.997] Timer tick, asking Buildbucket for the build status
[23:53:08.144] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:08.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:22:0) after 1m0s
[23:54:08.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:22:0)
[23:54:08.162] Timer tick, asking Buildbucket for the build status
[23:54:08.249] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:08.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:23:0) after 1m0s
[23:55:08.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:23:0)
[23:55:08.269] Timer tick, asking Buildbucket for the build status
[23:55:08.345] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:08.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:24:0) after 1m0s
[23:56:08.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:24:0)
[23:56:08.362] Timer tick, asking Buildbucket for the build status
[23:56:08.701] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:08.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:25:0) after 1m0s
[23:57:08.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:25:0)
[23:57:08.758] Timer tick, asking Buildbucket for the build status
[23:57:08.921] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:08.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:26:0) after 1m0s
[23:58:08.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:26:0)
[23:58:08.961] Timer tick, asking Buildbucket for the build status
[23:58:09.045] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:09.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:27:0) after 1m0s
[23:59:09.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:27:0)
[23:59:09.069] Timer tick, asking Buildbucket for the build status
[23:59:09.192] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:09.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:28:0) after 1m0s
[00:00:09.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:28:0)
[00:00:09.347] Timer tick, asking Buildbucket for the build status
[00:00:09.529] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:09.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:29:0) after 1m0s
[00:01:10.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:29:0)
[00:01:10.322] Timer tick, asking Buildbucket for the build status
[00:01:10.412] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:10.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:30:0) after 1m0s
[00:02:10.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:30:0)
[00:02:10.646] Timer tick, asking Buildbucket for the build status
[00:02:10.735] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:10.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:31:0) after 1m0s
[00:03:10.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:31:0)
[00:03:10.706] Timer tick, asking Buildbucket for the build status
[00:03:10.780] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:10.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:32:0) after 1m0s
[00:04:10.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:32:0)
[00:04:10.782] Timer tick, asking Buildbucket for the build status
[00:04:10.891] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:10.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:33:0) after 1m0s
[00:05:10.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:33:0)
[00:05:10.913] Timer tick, asking Buildbucket for the build status
[00:05:10.988] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:10.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:34:0) after 1m0s
[00:06:11.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:34:0)
[00:06:11.008] Timer tick, asking Buildbucket for the build status
[00:06:11.147] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:11.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:35:0) after 1m0s
[00:07:11.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:35:0)
[00:07:11.192] Timer tick, asking Buildbucket for the build status
[00:07:11.266] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:11.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:36:0) after 1m0s
[00:08:11.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:36:0)
[00:08:11.533] Timer tick, asking Buildbucket for the build status
[00:08:11.854] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:11.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:37:0) after 1m0s
[00:09:11.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:37:0)
[00:09:11.907] Timer tick, asking Buildbucket for the build status
[00:09:12.057] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:12.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:38:0) after 1m0s
[00:10:12.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:38:0)
[00:10:12.114] Timer tick, asking Buildbucket for the build status
[00:10:12.432] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:39:0) after 1m0s
[00:11:12.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:39:0)
[00:11:12.452] Timer tick, asking Buildbucket for the build status
[00:11:12.567] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:12.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:40:0) after 1m0s
[00:12:12.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:40:0)
[00:12:12.588] Timer tick, asking Buildbucket for the build status
[00:12:12.679] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:12.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:41:0) after 1m0s
[00:13:12.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:41:0)
[00:13:12.784] Timer tick, asking Buildbucket for the build status
[00:13:12.886] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:12.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:42:0) after 1m0s
[00:14:12.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:42:0)
[00:14:12.906] Timer tick, asking Buildbucket for the build status
[00:14:13.024] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:13.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:43:0) after 1m0s
[00:15:13.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:43:0)
[00:15:13.161] Timer tick, asking Buildbucket for the build status
[00:15:13.308] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:13.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:44:0) after 1m0s
[00:16:13.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:44:0)
[00:16:13.421] Timer tick, asking Buildbucket for the build status
[00:16:13.510] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:13.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:45:0) after 1m0s
[00:17:13.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:45:0)
[00:17:13.591] Timer tick, asking Buildbucket for the build status
[00:17:13.714] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:13.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:46:0) after 1m0s
[00:18:13.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:46:0)
[00:18:13.784] Timer tick, asking Buildbucket for the build status
[00:18:13.909] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:13.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:47:0) after 1m0s
[00:19:13.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:47:0)
[00:19:13.953] Timer tick, asking Buildbucket for the build status
[00:19:14.075] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:14.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:48:0) after 1m0s
[00:20:14.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:48:0)
[00:20:14.137] Timer tick, asking Buildbucket for the build status
[00:20:14.217] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:14.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:49:0) after 1m0s
[00:21:14.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:49:0)
[00:21:14.247] Timer tick, asking Buildbucket for the build status
[00:21:14.332] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:14.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:50:0) after 1m0s
[00:22:14.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:50:0)
[00:22:14.363] Timer tick, asking Buildbucket for the build status
[00:22:14.451] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:51:0) after 1m0s
[00:23:14.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:51:0)
[00:23:14.520] Timer tick, asking Buildbucket for the build status
[00:23:14.602] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:14.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:52:0) after 1m0s
[00:24:14.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:52:0)
[00:24:14.658] Timer tick, asking Buildbucket for the build status
[00:24:14.808] Build 8855187600914323600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020617663155102576:53:0) after 1m0s
[00:25:02.106] Received PubSub notification, asking Buildbucket for the build status
[00:25:02.191] Build 8855187600914323600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:25:02.191] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613435101044088",
"created_by": "project:chromium",
"created_ts": "1613432040256264",
"id": "8855187600914323600",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e897d7f2a0085f08bc3801753f5be47aae8c03e4\"}}",
"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\": \"e897d7f2a0085f08bc3801753f5be47aae8c03e4\", \"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-79-xanh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45438, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"e897d7f2a0085f08bc3801753f5be47aae8c03e4\", \"got_revision_cp\": \"refs/heads/master@{#854092}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"a24f3d035f7d9acee551d5547f4fb16838cf98d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33258}\", \"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\": \"e897d7f2a0085f08bc3801753f5be47aae8c03e4\", \"swarm_hashes_refs/heads/master(at){#854092}_without_patch\": {\"absl_hardening_tests\": \"da9b2fb411fe3bc3257ea956d5510b798325a542\", \"accessibility_unittests\": \"5acddeeea900df3a6818eac688305afbed0b3710\", \"angle_unittests\": \"4209db2d5c615ec922dcd8cda0eeb9b6eb20f892\", \"app_list_unittests\": \"dd95707f8b912560608e7b1422ce4df19d1ab679\", \"app_shell_unittests\": \"6604fb2813f1bb867396fe954a0a357a001266a0\", \"ash_unittests\": \"bbdee7bfd4dcd7aa1930cfc12fbd4317fcca871d\", \"aura_unittests\": \"7c5d2dc2321f7407f4e776ed49c524a49ebd6b3a\", \"base_unittests\": \"1773a88d60a7fc06dc0be7d92bb3ad458d551615\", \"base_util_unittests\": \"9f2625b4f21434dbfe800ac69a9ad6daf7c695d0\", \"blink_common_unittests\": \"4c4d93d4ba2788ca137c118a38475b8232ccfb70\", \"blink_fuzzer_unittests\": \"804d3436617bb0bcbdb49f4007b591666464c4d1\", \"blink_heap_unittests\": \"51a5b9f3b19222a194f9f89625bfeda609458dc9\", \"blink_platform_unittests\": \"51e2182a3855c0da81a0c0e31fd67e3234f213f8\", \"blink_unittests\": \"c656bec4abb6267f5c8b3f756eb7fdd0c415e9c2\", \"boringssl_crypto_tests\": \"24957053378da4dc9f3486ad96558713bb0ce20f\", \"boringssl_ssl_tests\": \"870c831930e434835010dd5708208fb1b8e2d8d9\", \"browser_tests\": \"6529f01429ef72c79551b0a8eab5f3e354549a80\", \"capture_unittests\": \"027ef4ada37529e312455738f6495e83c3211c7a\", \"cast_unittests\": \"616af3bdcfd64f549690ba718ba4d39891753b2c\", \"cc_unittests\": \"6106d8fad80beb857449848c0b5434307d392c72\", \"chrome_app_unittests\": \"5d8d856a489322e748aac827435fd37ab4916b5e\", \"chromedriver_unittests\": \"4f6200ab1600404f04680507f9cb9e5daf23398f\", \"chromeos_components_unittests\": \"ac8710b1ffe3ce04cb940e56c604d02516fc0eee\", \"chromeos_unittests\": \"a1c2fbd0dde3b7d0d0e1455b3cec775828b16d3b\", \"components_browsertests\": \"dbe1f178c79d12c1f6e76525a1da676961894ab1\", \"components_unittests\": \"531d5f86799819110314b55dffcf88cf95f79f7e\", \"compositor_unittests\": \"28ae6ab181aa94c30ae58b0988e712a366d4041b\", \"content_browsertests\": \"0bd421534b77309483fd41b918f51d264d3648a1\", \"content_unittests\": \"e2fd8710fda9e14d0b9d189f04beb193d34611fd\", \"crashpad_tests\": \"3917eb46eeef7f7c2a2eb77efb4cce4efdb5bcd3\", \"crypto_unittests\": \"03bc7fc0db9920f9780d6b53ba040a0045a6980f\", \"dbus_unittests\": \"a87bff0dde5d7e5a14bf28eb07c5d3950d70435d\", \"device_unittests\": \"3c351b3a9fd530dfbf985cf88a32fa48278b0128\", \"display_unittests\": \"ff4db0e26f7a3517bf8bf163a4e8be54d5eb6fbb\", \"events_unittests\": \"e1be3ab9d4305d204debb0d00dfe4be20ba554a4\", \"exo_unittests\": \"ff408602784e584abd4ed92594fe3d937e553406\", \"extensions_browsertests\": \"6e20102808f5971e03a372c05619cf85616b6138\", \"extensions_unittests\": \"3a92147f53470fe5b2535f30328ddb8d834faa89\", \"filesystem_service_unittests\": \"c73fd39a08e34b0acbb456d83436a322d39c8762\", \"gcm_unit_tests\": \"b516e7d0be2940180a6cb3f417d3ae233f52b774\", \"gfx_unittests\": \"9b195e3a7973d94d9236644892db7f66011166ac\", \"gin_unittests\": \"86ac9447380043c63563042505df16c15ff86072\", \"gl_unittests_ozone\": \"777bd71e169a7519d56dd79fd98fe21bf447e9eb\", \"google_apis_unittests\": \"ba1cfe9e9a5f575dd226a4248ac53310344db190\", \"gpu_unittests\": \"4e8249b902944318fc597e856638fc0a6cb8da03\", \"gwp_asan_unittests\": \"e73b4d4121848faff450d5b7d85d93e180d192c7\", \"interactive_ui_tests\": \"3a1294349e82c51e588908a70021281a1242a7ff\", \"ipc_tests\": \"4f7eea6c6e0fc8df8b16120803ac05655b48230f\", \"jingle_unittests\": \"49e4328a44ff76e6870753361e17f9c345c3e45b\", \"keyboard_unittests\": \"64919ab71028ea1309bd45a3a9c2dce170495aa0\", \"latency_unittests\": \"86afcbffbceefd4e313216812b3ddd12481754da\", \"libjingle_xmpp_unittests\": \"93bc1576d404a27112e6d67eb5b6fc115ee7799c\", \"liburlpattern_unittests\": \"607279cdf42e8239103863d029609e168e8d2d52\", \"media_blink_unittests\": \"5d64763bc6d7abcea06290a341a2df5ccc60a124\", \"media_unittests\": \"8adfc7ef9038e9d8088618a52619652683f27348\", \"message_center_unittests\": \"fe7df255c172e261a95a2bccf231ffdf6dd8ea6f\", \"midi_unittests\": \"9da667fd40f04d5bdfc9604f856ed5184ded1ed2\", \"mojo_core_unittests\": \"fdcfc6d82b7fe14643ed2fb8b0d094a8eba4fba8\", \"mojo_unittests\": \"cb050bb9125749efd0a0e1b33684ea23f9f7ed11\", \"nacl_helper_nonsfi_unittests\": \"5394d16e22e12df85a32d9090ab89ff429393b3d\", \"nacl_loader_unittests\": \"7cc1b40ae3bd81d69f32f5b941cb2dd61621c00f\", \"native_theme_unittests\": \"3a343a7f512f0448178ca877d817cb65638b5567\", \"net_unittests\": \"e63197844c203a46635a4c798d35e6d705ae9e85\", \"ozone_gl_unittests\": \"7beba6c75f79f680488e1b2c6d22401ae96fa49b\", \"ozone_unittests\": \"475f685ba9bd61a79315f9b20b06f4a4170f7ff6\", \"ozone_x11_unittests\": \"cdaa5f01189a546036215e3e550fd0eb0e18a609\", \"pdf_unittests\": \"87f2819c32a6a4d27d6e08a145324fd28ea0c518\", \"perfetto_unittests\": \"cf5c50e6d17ced0aa244bf394b6ac4283cfc47ef\", \"ppapi_unittests\": \"6b8e5d27310b6de7ac6555aa44d6c658f88265b3\", \"printing_unittests\": \"bbaab5cfde661f744cfb74d1d3d2d72423959e57\", \"remoting_unittests\": \"2f5e9403f1588660f1268e496d40c63e0e97bd58\", \"sandbox_linux_unittests\": \"c24f3b7abeaa3d4698a3d872614507b108aadf1b\", \"service_manager_unittests\": \"ade41a12472ed3d2e2a46faad6084d8ef15c0e86\", \"services_unittests\": \"d0d11ceac9695627df8bd00ab12c4a4ab3ea1b7e\", \"shell_dialogs_unittests\": \"8e2fe99a1dd83bb19eb0909738d849c9fde84901\", \"shell_encryption_unittests\": \"a5570fe4e4acc822b469c8fa776f09db764253ed\", \"skia_unittests\": \"870b4a00905eeda3b2e5ee96e333ac48bc6cd05c\", \"snapshot_unittests\": \"742c69d2c327f83a0fe54e75ddc3309fe3616788\", \"sql_unittests\": \"aca7fd358678b4c584ce079df8f89f3ec5867777\", \"storage_unittests\": \"5660f12609457ca0a92a5391fc62951fe582ee1d\", \"sync_integration_tests\": \"c2ec986fae1ad47827ef106c3a2090c1007ece20\", \"traffic_annotation_auditor_unittests\": \"979ed14280fb852b0fb179700c3405fd6d9e8361\", \"ui_base_unittests\": \"e148b6453314d45908a5f3c8931a21bbfed112fc\", \"ui_chromeos_unittests\": \"f575b1e7256831f328d74922f1824a52bc781098\", \"ui_touch_selection_unittests\": \"7388367a99e8738cf0dbd656989c979e357f2a94\", \"unit_tests\": \"96703ee74844d81f12827b447c4b86550b5e6682\", \"url_unittests\": \"6973d9784fe53ae9cd3142d4bd10d612d7ce90d7\", \"usage_time_limit_unittests\": \"b4b5061ef1934b03504a2426b10735daa4c5126b\", \"views_unittests\": \"f362d47378cf43979e734a1add61eeb5f3cd39c3\", \"viz_unittests\": \"8ff499d265014f4f108e3508ab65ce251e186c55\", \"wayland_client_perftests\": \"31b26035b5c89e59047f2b653bea7175c101bc19\", \"wm_unittests\": \"e70b3465bf9014a40c27a0f00079a70345284bdb\", \"wtf_unittests\": \"d8ce6d37d6e29a7792342f89c7faaea8ca9f3447\", \"zlib_unittests\": \"a8f4485d114f0347a162106d247151bcc274cba1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_a1c3d05f1886c3c1a4b693e8245da857a9c63a0cda58ad280c9a386162f50760_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-79-xanh\"], \"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\": [\"5696-2a606bc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613432064668992",
"status": "COMPLETED",
"status_changed_ts": "1613435101531894",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45438",
"builder:linux-chromeos-rel",
"buildset:commit/git/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e897d7f2a0085f08bc3801753f5be47aae8c03e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020617663155102576",
"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/8855187600914323600/+/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:51c0dcbc007b7710",
"user_agent:luci-scheduler"
],
"updated_ts": "1613435101535973",
"url": "https://ci.chromium.org/b/8855187600914323600",
"utcnow_ts": "1613435102182383"
}
}
[00:25:02.191] Invocation finished in 51m3.455318499s with status SUCCEEDED