[22:59:18.811] New invocation is queued and will start shortly
[22:59:19.923] Starting the invocation (attempt 1)
[22:59:19.983] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:59:19.983] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:59:19.983] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020982231997936624",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020982231997936624",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"gitiles_ref:refs/heads/master"
]
}
[22:59:20.762] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613084360068297",
"id": "8855552170015427056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613084360537563",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45340",
"builder:linux-chromeos-rel",
"buildset:commit/git/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020982231997936624",
"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/8855552170015427056/+/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": "1613084360537687",
"url": "https://ci.chromium.org/b/8855552170015427056",
"utcnow_ts": "1613084360749123"
}
}
[22:59:20.762] Task URL: https://ci.chromium.org/b/8855552170015427056
[22:59:20.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:2:0) after 1m0s
[22:59:22.543] Received PubSub notification, asking Buildbucket for the build status
[22:59:22.613] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:20.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:2:0)
[23:00:20.739] Timer tick, asking Buildbucket for the build status
[23:00:21.453] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:4:0) after 1m0s
[23:01:21.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:4:0)
[23:01:21.503] Timer tick, asking Buildbucket for the build status
[23:01:21.573] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:21.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:5:0) after 1m0s
[23:02:21.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:5:0)
[23:02:21.646] Timer tick, asking Buildbucket for the build status
[23:02:21.820] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:21.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:6:0) after 1m0s
[23:03:21.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:6:0)
[23:03:21.944] Timer tick, asking Buildbucket for the build status
[23:03:22.149] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:22.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:7:0) after 1m0s
[23:04:22.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:7:0)
[23:04:22.237] Timer tick, asking Buildbucket for the build status
[23:04:22.342] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:22.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:8:0) after 1m0s
[23:05:22.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:8:0)
[23:05:22.467] Timer tick, asking Buildbucket for the build status
[23:05:22.565] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:9:0) after 1m0s
[23:06:22.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:9:0)
[23:06:22.625] Timer tick, asking Buildbucket for the build status
[23:06:23.274] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:23.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:10:0) after 1m0s
[23:07:23.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:10:0)
[23:07:23.333] Timer tick, asking Buildbucket for the build status
[23:07:23.483] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:23.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:11:0) after 1m0s
[23:08:23.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:11:0)
[23:08:23.517] Timer tick, asking Buildbucket for the build status
[23:08:23.703] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:23.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:12:0) after 1m0s
[23:09:23.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:12:0)
[23:09:23.732] Timer tick, asking Buildbucket for the build status
[23:09:24.110] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:13:0) after 1m0s
[23:10:24.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:13:0)
[23:10:24.132] Timer tick, asking Buildbucket for the build status
[23:10:24.338] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:24.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:14:0) after 1m0s
[23:11:24.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:14:0)
[23:11:24.408] Timer tick, asking Buildbucket for the build status
[23:11:24.475] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:24.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:15:0) after 1m0s
[23:12:24.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:15:0)
[23:12:24.520] Timer tick, asking Buildbucket for the build status
[23:12:24.626] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:24.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:16:0) after 1m0s
[23:13:24.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:16:0)
[23:13:24.701] Timer tick, asking Buildbucket for the build status
[23:13:24.780] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:24.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:17:0) after 1m0s
[23:14:24.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:17:0)
[23:14:24.789] Timer tick, asking Buildbucket for the build status
[23:14:24.940] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:18:0) after 1m0s
[23:15:24.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:18:0)
[23:15:24.989] Timer tick, asking Buildbucket for the build status
[23:15:25.051] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:25.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:19:0) after 1m0s
[23:16:25.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:19:0)
[23:16:25.087] Timer tick, asking Buildbucket for the build status
[23:16:25.209] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:25.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:20:0) after 1m0s
[23:17:25.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:20:0)
[23:17:25.248] Timer tick, asking Buildbucket for the build status
[23:17:25.437] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:25.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:21:0) after 1m0s
[23:18:25.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:21:0)
[23:18:25.445] Timer tick, asking Buildbucket for the build status
[23:18:36.435] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:36.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:22:0) after 1m0s
[23:19:36.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:22:0)
[23:19:36.521] Timer tick, asking Buildbucket for the build status
[23:19:37.004] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:23:0) after 1m0s
[23:20:37.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:23:0)
[23:20:37.021] Timer tick, asking Buildbucket for the build status
[23:20:37.081] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:37.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:24:0) after 1m0s
[23:21:37.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:24:0)
[23:21:37.203] Timer tick, asking Buildbucket for the build status
[23:21:37.295] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:37.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:25:0) after 1m0s
[23:22:37.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:25:0)
[23:22:37.378] Timer tick, asking Buildbucket for the build status
[23:22:37.637] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:37.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:26:0) after 1m0s
[23:23:37.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:26:0)
[23:23:37.772] Timer tick, asking Buildbucket for the build status
[23:23:39.695] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:39.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:27:0) after 1m0s
[23:24:39.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:27:0)
[23:24:39.843] Timer tick, asking Buildbucket for the build status
[23:24:41.042] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:41.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:28:0) after 1m0s
[23:25:41.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:28:0)
[23:25:41.248] Timer tick, asking Buildbucket for the build status
[23:25:41.431] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:41.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:29:0) after 1m0s
[23:26:41.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:29:0)
[23:26:41.528] Timer tick, asking Buildbucket for the build status
[23:26:41.717] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:30:0) after 1m0s
[23:27:42.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:30:0)
[23:27:42.004] Timer tick, asking Buildbucket for the build status
[23:27:43.965] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:43.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:31:0) after 1m0s
[23:28:44.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:31:0)
[23:28:44.236] Timer tick, asking Buildbucket for the build status
[23:28:44.322] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:44.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:32:0) after 1m0s
[23:29:44.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:32:0)
[23:29:44.675] Timer tick, asking Buildbucket for the build status
[23:29:45.430] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:45.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:33:0) after 1m0s
[23:30:45.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:33:0)
[23:30:45.579] Timer tick, asking Buildbucket for the build status
[23:30:45.965] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:45.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:34:0) after 1m0s
[23:31:46.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:34:0)
[23:31:46.015] Timer tick, asking Buildbucket for the build status
[23:31:46.226] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:35:0) after 1m0s
[23:32:46.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:35:0)
[23:32:46.286] Timer tick, asking Buildbucket for the build status
[23:32:46.381] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:46.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:36:0) after 1m0s
[23:33:46.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:36:0)
[23:33:46.428] Timer tick, asking Buildbucket for the build status
[23:33:46.547] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:46.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:37:0) after 1m0s
[23:34:46.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:37:0)
[23:34:46.581] Timer tick, asking Buildbucket for the build status
[23:34:46.780] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:46.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:38:0) after 1m0s
[23:35:46.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:38:0)
[23:35:46.857] Timer tick, asking Buildbucket for the build status
[23:35:47.042] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:47.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:39:0) after 1m0s
[23:36:47.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:39:0)
[23:36:47.249] Timer tick, asking Buildbucket for the build status
[23:36:49.119] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:40:0) after 1m0s
[23:37:49.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:40:0)
[23:37:49.494] Timer tick, asking Buildbucket for the build status
[23:37:49.827] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:41:0) after 1m0s
[23:38:49.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:41:0)
[23:38:49.822] Timer tick, asking Buildbucket for the build status
[23:38:51.770] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:51.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:42:0) after 1m0s
[23:39:51.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:42:0)
[23:39:51.914] Timer tick, asking Buildbucket for the build status
[23:39:52.014] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:52.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:43:0) after 1m0s
[23:40:52.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:43:0)
[23:40:52.018] Timer tick, asking Buildbucket for the build status
[23:40:52.112] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:52.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:44:0) after 1m0s
[23:41:52.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:44:0)
[23:41:52.141] Timer tick, asking Buildbucket for the build status
[23:41:52.250] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:52.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:45:0) after 1m0s
[23:42:52.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:45:0)
[23:42:52.252] Timer tick, asking Buildbucket for the build status
[23:42:52.334] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:52.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:46:0) after 1m0s
[23:43:52.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:46:0)
[23:43:52.426] Timer tick, asking Buildbucket for the build status
[23:43:52.519] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:52.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:47:0) after 1m0s
[23:44:52.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:47:0)
[23:44:52.537] Timer tick, asking Buildbucket for the build status
[23:44:52.935] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:52.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:48:0) after 1m0s
[23:45:52.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:48:0)
[23:45:52.979] Timer tick, asking Buildbucket for the build status
[23:45:53.106] Build 8855552170015427056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:53.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020982231997936624:49:0) after 1m0s
[23:46:44.944] Received PubSub notification, asking Buildbucket for the build status
[23:46:45.109] Build 8855552170015427056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:46:45.109] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613087204110867",
"created_by": "project:chromium",
"created_ts": "1613084360068297",
"id": "8855552170015427056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\"}}",
"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\": \"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\", \"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-39-99tq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45340, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e9f42997b213f1b287aa31698e22b2bca6976853\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\", \"got_revision_cp\": \"refs/heads/master@{#853265}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"00ea60a40e748000e049a0551eb8d3f46a0db714\", \"got_v8_revision_cp\": \"refs/heads/9.0.165@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"87ed8b1ba56f18e3773b885daeafb59ad26d62e7\", \"swarm_hashes_refs/heads/master(at){#853265}_without_patch\": {\"absl_hardening_tests\": \"44fb61fd81d55856ca7dcf4fa78601b025477f6e\", \"accessibility_unittests\": \"0398e45893f891852c0fd30f5af9643d74ec4987\", \"angle_unittests\": \"8db89b0fe320c7a07296e4e6798c31466b23f272\", \"app_list_unittests\": \"88f09ea41977bfb6cfa508fc83fe1f76737d46eb\", \"app_shell_unittests\": \"117159c37376d82ee8820301c67692799f6dc181\", \"ash_unittests\": \"aa56a1242ff850a51b8750f92008e07b7df96306\", \"aura_unittests\": \"56b20f8a56f1d87940e30aa6d1ec9407aaf4567f\", \"base_unittests\": \"88d1e2de1d3a8f821dd5e2dbf2940ce348faaf28\", \"base_util_unittests\": \"d7738240fda46d733dab92f55abc57fb77fb60b7\", \"blink_common_unittests\": \"6f83517cc08e31f7ddfa4afab142418ea8071a2e\", \"blink_fuzzer_unittests\": \"e3d4e2efdc9e32ca5da771976ef8c03e1dc798c3\", \"blink_heap_unittests\": \"82f9943fa6ded804c28e803098bf20565b693f7f\", \"blink_platform_unittests\": \"f59ef3e61fdd1f1200637181e21edab801723770\", \"blink_unittests\": \"c16c9256facdc565888fa35ffd744c9015e8b9c4\", \"boringssl_crypto_tests\": \"ea73cc49a2deef1cc67aa043f900862e53dedea6\", \"boringssl_ssl_tests\": \"ecf6ab5881a92155cd80e754c18973a46440dde9\", \"browser_tests\": \"8c8dc00bbdc617bd01c9657a045da15dcb25c5ab\", \"capture_unittests\": \"fda5d4f358befa96528f417e8c1ac1081a7102d8\", \"cast_unittests\": \"58b88d062ab0c76182de601b586ae6ab3a9a4eb8\", \"cc_unittests\": \"d826004b2daab741ff5cd11422af6d94ea3dae79\", \"chrome_app_unittests\": \"487d9af2e6cf1637d0a8b6f9caa8285766210326\", \"chromedriver_unittests\": \"74d8a9e6ad7dfd8462ca9ab7cc045ca43e772bec\", \"chromeos_components_unittests\": \"5ceed2251fe69aea1dbc1f4694af1ce61a98371c\", \"chromeos_unittests\": \"61f3c0149d73cd0806a2af158f5b012dfc6c9085\", \"components_browsertests\": \"69690295f1fe7f8144deea043058f207aff79d51\", \"components_unittests\": \"79fd0a94c17d9d163d35c0d410dbfeeeac4fadc1\", \"compositor_unittests\": \"1c1993ed992f3b79bdd62ad37b64929549abff8f\", \"content_browsertests\": \"6ff7b7c5edbe6f193b7136f4da282fa7b86eacf7\", \"content_unittests\": \"d1737025255e34ae965856b7d6e15abac860bd85\", \"crashpad_tests\": \"07ec4b1716d1d9404ae99a69bb4d3475928d71ec\", \"crypto_unittests\": \"86e60e9a83d0e25e177bb1f6965d38c667544200\", \"dbus_unittests\": \"4c54fb62776825bdb7b4c78d2a60ad4c9359ce1e\", \"device_unittests\": \"fb0998fcbb476a8d36747c834aadc206df794348\", \"display_unittests\": \"f329965d36204f2c4866442fec7b476b1d0a9f11\", \"events_unittests\": \"eeb9410aa7fafed2ecaff55476084318e59c280f\", \"exo_unittests\": \"2028f9ebf8f99bfe0bcf9a192faa1e48919942ce\", \"extensions_browsertests\": \"24829e3ad956e92069ba56f83fc7b4e16a384215\", \"extensions_unittests\": \"39f9fc278f02ec0d1b9dcd0cdea93618f8a5e884\", \"filesystem_service_unittests\": \"7c4d3607117ae850af74df52b48e5a4d6de10adf\", \"gcm_unit_tests\": \"dae9771c072d778a1aa565db3c4e838d0fad1bd2\", \"gfx_unittests\": \"e8c23ab6df8d842cdfa7df82a64c2c58df9f8a67\", \"gin_unittests\": \"c2510b9e4d243f566358885262b0f9a119c94c1f\", \"gl_unittests_ozone\": \"e6e9633d07bee856c13e78054c1eb8a25d409263\", \"google_apis_unittests\": \"a7fa4c281daa760941b9eb867a7eedabf22bd05c\", \"gpu_unittests\": \"b210e730fe30eedeb4b47de38bf0d7a6fba974f0\", \"gwp_asan_unittests\": \"ce315c58c87badd633c618b5663b16ac47624b2b\", \"interactive_ui_tests\": \"e679376631aeca95fe98bfd891ae88c0b3fe6f09\", \"ipc_tests\": \"2d2689bbc64df8f45234162554e5305795a17275\", \"jingle_unittests\": \"274b8f508fed473e8ad99fdcd8b87799f1d8ac2b\", \"keyboard_unittests\": \"647239b3b59e4c4742b60cfa9740e5535ca61795\", \"latency_unittests\": \"3edf65b8722453adb49383f650f1f5af78f2f367\", \"libjingle_xmpp_unittests\": \"224f6717ce848c94d070ac0d6c80e35d8240dc3c\", \"liburlpattern_unittests\": \"5d3271709661c7a039ee87145e13ec1a9ca0eb0b\", \"media_blink_unittests\": \"ae3b5534c71c5290f2d02998b4b0bb2f60cb38b7\", \"media_unittests\": \"e11a99739078a4e0aa1292315e5ed17dadb8a622\", \"message_center_unittests\": \"3559f152a5ccdbaa2b0aba38ac76699710cba148\", \"midi_unittests\": \"a24652c851ab1ab4cbd4b26a58aa8d135874f2dd\", \"mojo_core_unittests\": \"167b962d3f40f0fb430fdf3a5d0f939eb1ca2d23\", \"mojo_unittests\": \"a2c5f2b0812ce5569142f654b234527adce49d5c\", \"nacl_helper_nonsfi_unittests\": \"01da93c352e30daebee34d196fbec1a31442232d\", \"nacl_loader_unittests\": \"05bda3c5abe5f7b74eed6d260188160320c02510\", \"native_theme_unittests\": \"518c42cf020be1e9a9d066f0ae4893b55d6b0666\", \"net_unittests\": \"e99d6dab220fca48714029e3c06e949f4e46c415\", \"ozone_gl_unittests\": \"7ac387ef96e68640bbbfb6de993172f67a3189a9\", \"ozone_unittests\": \"80347ee6dfc8ff87b320f646880fb7797572b3fa\", \"ozone_x11_unittests\": \"6cba38f97f2b1454af873f709a66f0db90131ec2\", \"pdf_unittests\": \"e11b5d84bc9270509deb727fce26e96a37387d21\", \"perfetto_unittests\": \"a62467e7773e4c7c7e0153f418101502e3f0ba3b\", \"ppapi_unittests\": \"36610b2f4b85ed5cfbcae977a8eb38418565a215\", \"printing_unittests\": \"ae6100e30b2744d3269ace7254fd44cc39834c1d\", \"remoting_unittests\": \"d843bb2e7616954e859cfab7e68c226d2ff5ca41\", \"sandbox_linux_unittests\": \"58e4cce005c1546ab4726af39dafd91c238402b6\", \"service_manager_unittests\": \"da205d83d442ccc7bd127a15e90394427400f13e\", \"services_unittests\": \"62127affbd0dd0f0a0ac2d5e86e8b60193b2ab56\", \"shell_dialogs_unittests\": \"383965867f0c507c59b67f96fb5a662f1ad5ddf8\", \"shell_encryption_unittests\": \"f3259bd3793cf4a7e1f3fd09c345ab83f7b8c452\", \"skia_unittests\": \"b973eb7185287a7e76c1c6b2d9446486cd2bfe6b\", \"snapshot_unittests\": \"67ad8d2f27c07bcedef3fe95f01fcf129bbdc0e6\", \"sql_unittests\": \"dc580c7ab3ef3fa51d312e792a6f73e5f6d15284\", \"storage_unittests\": \"8cc6b307ce537b3be8a3ca4990edda994468abbc\", \"sync_integration_tests\": \"aaaf2ddf74d4740b8cd0cad583dcf67f6263c744\", \"traffic_annotation_auditor_unittests\": \"983c0775cd89bbdd34c7e929d39106d9efa2dc81\", \"ui_base_unittests\": \"d63802f04ce6674a037e14b10c8df43486b059ff\", \"ui_chromeos_unittests\": \"e3f8fcd599ec0ab3ced77a8913b800cbab729ba4\", \"ui_touch_selection_unittests\": \"be37156ae320fe4ddb747de7f9b6b2001326691c\", \"unit_tests\": \"90f458f1c3cebfeff34476e164c84d949c3c2aad\", \"url_unittests\": \"6d1b2c2e6d428c8d900b083c853924d0ad768a3d\", \"usage_time_limit_unittests\": \"2555ac433ca5246034733ee1eb9ab30ea996f7da\", \"views_unittests\": \"f1b8e54a91e574ff4706ba25757e64f1fa5d46fa\", \"viz_unittests\": \"9c11920ce6c179311cfd5cbdd43934cf46e03ae7\", \"wayland_client_perftests\": \"9ad1031a02db69b693eec1975afa4d8d1c063289\", \"wm_unittests\": \"b90280410cc9976279eddcc8cefccfdf16ba5e97\", \"wtf_unittests\": \"310e8f7d193832a7a56d0791d0febc6fd928f421\", \"zlib_unittests\": \"55e54924178b5714add884e937806bf18165dd11\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_80caf7430a3f42346120b86a5d4a8c20619a8e115748218c5e2ff55c5518ef8d_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_c49efc2b6fcfe67b72a35f6b436282fc6c4393b61b532dfc8ddacf832f201b2b_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-39-99tq\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613084361644335",
"status": "COMPLETED",
"status_changed_ts": "1613087204416867",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45340",
"builder:linux-chromeos-rel",
"buildset:commit/git/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/87ed8b1ba56f18e3773b885daeafb59ad26d62e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020982231997936624",
"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/8855552170015427056/+/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:51ac23894c2d0b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613087204421938",
"url": "https://ci.chromium.org/b/8855552170015427056",
"utcnow_ts": "1613087205089288"
}
}
[23:46:45.109] Invocation finished in 47m26.315600177s with status SUCCEEDED