[11:25:29.151] New invocation is queued and will start shortly
[11:25:30.235] Starting the invocation (attempt 1)
[11:25:30.281] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:25:30.281] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:25:30.281] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021297674758778672",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8c3bf31a8138beb96423a292f0058db5c91d1f1c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021297674758778672",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"gitiles_ref:refs/heads/master"
]
}
[11:25:31.258] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612783530392207",
"id": "8855867612793665648",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8c3bf31a8138beb96423a292f0058db5c91d1f1c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612783531149499",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180379",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021297674758778672",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855867612793665648/+/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": "1612783531149724",
"url": "https://ci.chromium.org/b/8855867612793665648",
"utcnow_ts": "1612783531249288"
}
}
[11:25:31.259] Task URL: https://ci.chromium.org/b/8855867612793665648
[11:25:31.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:2:0) after 1m0s
[11:25:36.410] Received PubSub notification, asking Buildbucket for the build status
[11:25:36.505] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:31.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:2:0)
[11:26:31.299] Timer tick, asking Buildbucket for the build status
[11:26:31.680] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:31.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:4:0) after 1m0s
[11:27:31.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:4:0)
[11:27:31.816] Timer tick, asking Buildbucket for the build status
[11:27:31.870] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:31.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:5:0) after 1m0s
[11:28:31.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:5:0)
[11:28:31.977] Timer tick, asking Buildbucket for the build status
[11:28:33.044] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:33.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:6:0) after 1m0s
[11:29:33.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:6:0)
[11:29:33.104] Timer tick, asking Buildbucket for the build status
[11:29:33.206] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:33.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:7:0) after 1m0s
[11:30:33.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:7:0)
[11:30:33.236] Timer tick, asking Buildbucket for the build status
[11:30:33.400] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:33.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:8:0) after 1m0s
[11:31:33.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:8:0)
[11:31:33.441] Timer tick, asking Buildbucket for the build status
[11:31:33.804] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:33.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:9:0) after 1m0s
[11:32:33.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:9:0)
[11:32:33.865] Timer tick, asking Buildbucket for the build status
[11:32:34.025] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:10:0) after 1m0s
[11:33:34.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:10:0)
[11:33:34.052] Timer tick, asking Buildbucket for the build status
[11:33:34.132] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:34.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:11:0) after 1m0s
[11:34:34.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:11:0)
[11:34:34.232] Timer tick, asking Buildbucket for the build status
[11:34:34.411] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:34.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:12:0) after 1m0s
[11:35:34.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:12:0)
[11:35:34.473] Timer tick, asking Buildbucket for the build status
[11:35:34.815] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:34.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:13:0) after 1m0s
[11:36:34.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:13:0)
[11:36:34.865] Timer tick, asking Buildbucket for the build status
[11:36:35.195] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:35.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:14:0) after 1m0s
[11:37:35.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:14:0)
[11:37:35.283] Timer tick, asking Buildbucket for the build status
[11:37:35.360] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:35.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:15:0) after 1m0s
[11:38:35.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:15:0)
[11:38:35.411] Timer tick, asking Buildbucket for the build status
[11:38:36.042] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:16:0) after 1m0s
[11:39:36.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:16:0)
[11:39:36.209] Timer tick, asking Buildbucket for the build status
[11:39:36.273] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:17:0) after 1m0s
[11:40:36.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:17:0)
[11:40:36.324] Timer tick, asking Buildbucket for the build status
[11:40:36.438] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:36.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:18:0) after 1m0s
[11:41:36.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:18:0)
[11:41:36.492] Timer tick, asking Buildbucket for the build status
[11:41:36.585] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:36.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:19:0) after 1m0s
[11:42:36.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:19:0)
[11:42:36.606] Timer tick, asking Buildbucket for the build status
[11:42:36.807] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:36.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:20:0) after 1m0s
[11:43:36.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:20:0)
[11:43:36.950] Timer tick, asking Buildbucket for the build status
[11:43:37.019] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:37.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:21:0) after 1m0s
[11:44:37.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:21:0)
[11:44:37.188] Timer tick, asking Buildbucket for the build status
[11:44:37.265] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:37.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:22:0) after 1m0s
[11:45:37.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:22:0)
[11:45:37.430] Timer tick, asking Buildbucket for the build status
[11:45:37.709] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:37.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:23:0) after 1m0s
[11:46:37.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:23:0)
[11:46:37.769] Timer tick, asking Buildbucket for the build status
[11:46:37.830] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:37.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:24:0) after 1m0s
[11:47:37.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:24:0)
[11:47:37.884] Timer tick, asking Buildbucket for the build status
[11:47:38.169] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:38.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:25:0) after 1m0s
[11:48:38.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:25:0)
[11:48:38.208] Timer tick, asking Buildbucket for the build status
[11:48:38.274] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:38.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:26:0) after 1m0s
[11:49:38.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:26:0)
[11:49:38.295] Timer tick, asking Buildbucket for the build status
[11:49:38.360] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:38.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:27:0) after 1m0s
[11:50:38.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:27:0)
[11:50:38.404] Timer tick, asking Buildbucket for the build status
[11:50:38.770] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:38.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:28:0) after 1m0s
[11:51:38.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:28:0)
[11:51:38.775] Timer tick, asking Buildbucket for the build status
[11:51:38.827] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:38.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:29:0) after 1m0s
[11:52:38.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:29:0)
[11:52:38.963] Timer tick, asking Buildbucket for the build status
[11:52:39.028] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:39.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:30:0) after 1m0s
[11:53:39.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:30:0)
[11:53:39.152] Timer tick, asking Buildbucket for the build status
[11:53:39.205] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:31:0) after 1m0s
[11:54:39.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:31:0)
[11:54:39.236] Timer tick, asking Buildbucket for the build status
[11:54:39.714] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:39.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:32:0) after 1m0s
[11:55:39.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:32:0)
[11:55:39.797] Timer tick, asking Buildbucket for the build status
[11:55:39.905] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:39.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:33:0) after 1m0s
[11:56:39.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:33:0)
[11:56:39.931] Timer tick, asking Buildbucket for the build status
[11:56:40.002] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:40.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:34:0) after 1m0s
[11:57:40.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:34:0)
[11:57:40.151] Timer tick, asking Buildbucket for the build status
[11:57:40.208] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:40.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:35:0) after 1m0s
[11:58:40.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:35:0)
[11:58:40.229] Timer tick, asking Buildbucket for the build status
[11:58:40.861] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:40.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:36:0) after 1m0s
[11:59:40.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:36:0)
[11:59:40.886] Timer tick, asking Buildbucket for the build status
[11:59:40.960] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:40.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:37:0) after 1m0s
[12:00:41.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:37:0)
[12:00:41.011] Timer tick, asking Buildbucket for the build status
[12:00:41.287] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:41.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:38:0) after 1m0s
[12:01:41.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:38:0)
[12:01:41.325] Timer tick, asking Buildbucket for the build status
[12:01:42.362] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:42.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:39:0) after 1m0s
[12:02:43.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:39:0)
[12:02:43.085] Timer tick, asking Buildbucket for the build status
[12:02:43.491] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:43.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:40:0) after 1m0s
[12:03:46.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:40:0)
[12:03:46.115] Timer tick, asking Buildbucket for the build status
[12:03:46.177] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:46.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:41:0) after 1m0s
[12:04:46.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:41:0)
[12:04:46.188] Timer tick, asking Buildbucket for the build status
[12:04:46.295] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:46.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:42:0) after 1m0s
[12:05:46.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:42:0)
[12:05:46.342] Timer tick, asking Buildbucket for the build status
[12:05:46.460] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:46.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:43:0) after 1m0s
[12:06:46.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:43:0)
[12:06:46.568] Timer tick, asking Buildbucket for the build status
[12:06:46.681] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:46.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:44:0) after 1m0s
[12:07:46.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:44:0)
[12:07:46.727] Timer tick, asking Buildbucket for the build status
[12:07:46.846] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:46.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:45:0) after 1m0s
[12:08:46.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:45:0)
[12:08:46.873] Timer tick, asking Buildbucket for the build status
[12:08:47.033] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:47.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:46:0) after 1m0s
[12:09:47.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:46:0)
[12:09:47.103] Timer tick, asking Buildbucket for the build status
[12:09:47.198] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:47.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:47:0) after 1m0s
[12:10:47.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:47:0)
[12:10:47.290] Timer tick, asking Buildbucket for the build status
[12:10:47.768] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:48:0) after 1m0s
[12:11:47.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:48:0)
[12:11:47.793] Timer tick, asking Buildbucket for the build status
[12:11:48.052] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:48.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:49:0) after 1m0s
[12:12:48.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:49:0)
[12:12:48.040] Timer tick, asking Buildbucket for the build status
[12:12:48.110] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:48.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:50:0) after 1m0s
[12:13:48.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:50:0)
[12:13:48.186] Timer tick, asking Buildbucket for the build status
[12:13:48.242] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:48.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:51:0) after 1m0s
[12:14:48.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:51:0)
[12:14:48.304] Timer tick, asking Buildbucket for the build status
[12:14:48.654] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:52:0) after 1m0s
[12:15:48.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:52:0)
[12:15:48.738] Timer tick, asking Buildbucket for the build status
[12:15:48.977] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:48.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:53:0) after 1m0s
[12:16:49.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:53:0)
[12:16:49.007] Timer tick, asking Buildbucket for the build status
[12:16:49.082] Build 8855867612793665648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:49.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021297674758778672:54:0) after 1m0s
[12:16:52.334] Received PubSub notification, asking Buildbucket for the build status
[12:16:53.444] Build 8855867612793665648: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:16:53.444] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612786610130824",
"created_by": "project:chromium",
"created_ts": "1612783530392207",
"id": "8855867612793665648",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8c3bf31a8138beb96423a292f0058db5c91d1f1c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"8c3bf31a8138beb96423a292f0058db5c91d1f1c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-62-jhhu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180379, \"got_angle_revision\": \"5712107a35b053c2e4ffb3a5690e6e482a0c84f5\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"8c3bf31a8138beb96423a292f0058db5c91d1f1c\", \"got_revision_cp\": \"refs/heads/master@{#851660}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"0b911e791ef3aefc64d94c7c36b35f010acd7dc0\", \"got_v8_revision_cp\": \"refs/heads/9.0.139@{#1}\", \"got_webrtc_revision\": \"69c0118c5139a1a6b431d2f3f812dc9ed6af6b74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33186}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8c3bf31a8138beb96423a292f0058db5c91d1f1c\", \"swarm_hashes_refs/heads/master(at){#851660}_without_patch\": {\"absl_hardening_tests\": \"5de7b58dcd7ff402ab626056e1f98bb3520da553\", \"accessibility_unittests\": \"4b46acd4a47e74efe662cbbb4e46a4af66800b16\", \"angle_unittests\": \"68ceb08691741002fb21259d54f691223e622722\", \"app_shell_unittests\": \"c972fa885d0dec375a3bddc555d625822195a64e\", \"aura_unittests\": \"8b60953ea1fd4d725bef1e5e6c9211a1dd0d8f8c\", \"base_unittests\": \"3166bf408b321d31efd92face3125528f624e10b\", \"base_util_unittests\": \"001c42a621f0ca83822df0222cfc8a07b65d6039\", \"blink_common_unittests\": \"9c33ae2432849e7f0f5402445f4a4f2c3517f3dc\", \"blink_fuzzer_unittests\": \"6a8251c23090014ee934a0ceef650a8654e3f99e\", \"blink_heap_unittests\": \"ce1911341ddd91dcff4891b5e0405773900a1173\", \"blink_platform_unittests\": \"aa26ba4f56e5960a5285d771f5a7b3dc039ed462\", \"blink_python_tests\": \"b7999a36ed16d9eb9b0760528c2547e69086b64d\", \"blink_unittests\": \"2bd8bd419912093344e45c90fd2f8340c9836323\", \"blink_web_tests\": \"5160d3870ce40363a1a654a5f1190e778eb1b99b\", \"boringssl_crypto_tests\": \"4bd39aa0825d5bfc30d0840f6afc4d24f662f2ce\", \"boringssl_ssl_tests\": \"7b4c177e9caa7681c1e63e90c2f785740532db71\", \"browser_tests\": \"11a528fa8c8234b3b75cfb8adadf3988dd9e3c4c\", \"capture_unittests\": \"b2bed961f1d475df0a83275cc4f09eb184297ad3\", \"cast_unittests\": \"a48b3de7af8f5343de4840b9a299f2433c36d31b\", \"cc_unittests\": \"a80fdd29b9d1022d15304666464acd0ddd228222\", \"chrome_app_unittests\": \"4ea0c2a8ef941ce23f7834e2f573dde7d38c7a2f\", \"chromedriver_unittests\": \"aaff185aff63a5638bdd69a493b2fbc51ecd536e\", \"components_browsertests\": \"d08f99ae100556fd542d0dbd58578167e6b34efd\", \"components_unittests\": \"8bd9042959b0066b165da01a769e8ea138c831c8\", \"compositor_unittests\": \"b516556856f897a97ecd11b31cdc37026ff20b62\", \"content_browsertests\": \"71bb1adcf3f6ef71d4435df06cd938d63d88e3da\", \"content_shell_crash_test\": \"e0c7d40e7cb4086e640b594dbcb83433d494a92e\", \"content_unittests\": \"d46981ce915297a21e0ff2ae235fab39365c2d2e\", \"crashpad_tests\": \"316f8bd0bf41d308fed3574cf925355cdfed16c4\", \"cronet_tests\": \"5b6b92c26a524c9cf217afe4ff12b212f3ab62a6\", \"cronet_unittests\": \"28c6ef3bb206c6c245e31f0b134acfa7b1aee78e\", \"crypto_unittests\": \"f55c9dd009edfcd217475692c0b63510d19ec788\", \"dbus_unittests\": \"2cc9c4c013597164318c11eff19d1a374b099db1\", \"device_unittests\": \"349639b39df656a3351f5845421081347bd09186\", \"display_unittests\": \"b9e168e491b2eea99213f1765331cf9c25a88fdb\", \"events_unittests\": \"e0e1cb7175a39240496c99855f9a3e4152a2339d\", \"extensions_browsertests\": \"7375ab84453b86e9e1358d74a728a0af2241b309\", \"extensions_unittests\": \"ff94dc99c06448ea27aca50e9fff2815da6da00a\", \"filesystem_service_unittests\": \"3a5b729753fe1e54d668fd52697593f2cee2a601\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"27c2791fb0ce2960503ccb4d8d26e5640a83af76\", \"gfx_unittests\": \"263cdf1d23200c8cf86d3a4626135daa9f71e0c3\", \"gin_unittests\": \"b2526f5f10ac37601491eedf6f103f8b1beb8f1a\", \"google_apis_unittests\": \"24a92d1c8b88543c4520f0eace19d04812661a14\", \"gpu_unittests\": \"df109cb02b997b791a3ff71dfb60d339d90be1c4\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"14ac187a6c6a25426e41e0ba8937c7ba7acc671b\", \"headless_browsertests\": \"e58f4e86a0ff4b9ff9f257c1fbf6ea83cd8ac411\", \"headless_unittests\": \"d8dd22a084543a9b7dd61296748122a6ab8f7154\", \"interactive_ui_tests\": \"b96237b4f4bd720444d750fd5189a3e6cf992116\", \"ipc_tests\": \"79401cd734f9cbc808bbeed9cc0832147311176f\", \"jingle_unittests\": \"22b631544e73f853180a5ea4a4dc46d8b6376a6c\", \"latency_unittests\": \"a916737d5b9344df118dfe8f080ec5c56e44670b\", \"libjingle_xmpp_unittests\": \"5474c43bbdf00c1de3a869a87767d4ab39332140\", \"liburlpattern_unittests\": \"841b8b27802709b58e365b1fb2a246a6b28aebe0\", \"media_blink_unittests\": \"cb5601f95e35aaa143a4d74d4bc1430f0b6ccb67\", \"media_unittests\": \"c41c33fe6712edadfd603f90fd133612216e812c\", \"message_center_unittests\": \"fcc3a53177a6eb9110fd274d83759615fa0800c3\", \"metrics_python_tests\": \"26f4672e4cd53bd6d042f9c7303a0043a3c15a05\", \"midi_unittests\": \"f4fd43e198c014d6791f9d93a855975a1f11b563\", \"mojo_core_unittests\": \"156d29dd394068da8a7326700455479159a31f5a\", \"mojo_unittests\": \"2085e2e90b6606ed4dd873fbdabd7a8d10f8a94c\", \"nacl_helper_nonsfi_unittests\": \"20b176c7d120314bb526796710ab6a0b410e9de3\", \"nacl_loader_unittests\": \"5754be58e1e5d6a47216a3f405c54de8175f9206\", \"native_theme_unittests\": \"f39bd1ef5eb819628adb98997f4a1cbf661bf859\", \"net_unittests\": \"8c7bbef54147360e59eacd1fbef5b2c317534d1f\", \"openscreen_unittests\": \"78725cdcc8855c2e60e038c2de42ecbda99b8801\", \"pdf_unittests\": \"11cdd2eb0f83b33fed43dc177bd15eaf3094beb6\", \"perfetto_unittests\": \"62dbe4c064bfd9a5a8d2faf5cbaf8560bf6d505b\", \"ppapi_unittests\": \"d5abb8a0f658b2751f437252e90bb52ecbadf655\", \"printing_unittests\": \"c56bb05945501fb45040a1a6b347a3fe9e572b5c\", \"remoting_unittests\": \"f0279f7f86983581c840680d5e0e18849211f3fe\", \"sandbox_linux_unittests\": \"dee95f01c7ffaddeff36818098d8a05600297a5f\", \"service_manager_unittests\": \"5ff8acea76ad07337d60839b97bd38c931b6d0ad\", \"services_unittests\": \"9b2761ef4b114f5f1723f2c62e6b5e160dcc5d55\", \"shell_dialogs_unittests\": \"01f30a001a381eb3fcd60610ae6caab56adcbd01\", \"skia_unittests\": \"280fdbca64fc1133916d5d9378baff37fcd776a4\", \"snapshot_unittests\": \"487a61151d0053961f8c9dad4e6334355cee6b73\", \"sql_unittests\": \"263ef77c7269029c44ac7e2de671fcc0ecf0aead\", \"storage_unittests\": \"8de33baddea24330f03c45159e085aedbe8ced7b\", \"sync_integration_tests\": \"9790c0373b41b43e696eb0b616e4ed7ed8ff1b76\", \"telemetry_gpu_unittests\": \"252aa7d2cc0998e174bb70e3be94c57b1f1aee6a\", \"telemetry_perf_unittests\": \"fb81360361c4bf1bb64d703c23882d1ddb448f59\", \"telemetry_unittests\": \"9d35a5f74aff9d5aa118c9abb02be06b5299f548\", \"traffic_annotation_auditor_unittests\": \"d2d7fc4689e14bb85940adfa71251c162771183c\", \"ui_base_unittests\": \"c165f75799cf97d3e2315f1a87b10faefa54a36e\", \"ui_touch_selection_unittests\": \"f76247ccac4068f40169931a735763e07bd89adc\", \"unit_tests\": \"e5e6dff0b8a9bf61ee30447850f7d3b4e17e7af0\", \"url_unittests\": \"e1f32fa799920f9065d2ae7e0193abf823564c31\", \"views_perftests\": \"732a7ee711d880ec1a34989f32435bc35073aea6\", \"views_unittests\": \"5f9061c64819f79a6857c1c48ab83775daa80943\", \"viz_unittests\": \"239459bfa6ebbd8048d7d6c1b4092731988aa6be\", \"vr_common_unittests\": \"2421fed3080631c14061d557300f3ab11530fd00\", \"vr_pixeltests\": \"2c28e07930287cbf36bea8e907a3cb1f17054bc9\", \"webdriver_wpt_tests\": \"eb2305b03fd4764bdf7cd9a24a6031c8a0e6eba4\", \"weblayer_browsertests\": \"6bf4f113ba64b80eeb2c1675b56560babdbc3c8c\", \"weblayer_unittests\": \"a1a09268a7a770950a27ead24c2f1319c4601fea\", \"wm_unittests\": \"a7c679506af577971454f9d916599bb37a700e59\", \"wtf_unittests\": \"cdb2ac8b7c1525a17c12ff3f9cec0d4e180c8777\", \"x11_unittests\": \"7ca17f768cf8c3e33de6b2d173516f5aa39c0bf2\", \"xr_browser_tests\": \"fe69ce70137064dae58abc185380c9d0ab1a5f42\", \"zlib_unittests\": \"89504cabc863a849ce5c68f46c95c0cf3ae8a155\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_7f949073f7e904bb9563d7870e146ee8e8e8f26011cb03330fcb60d1fc06c798_v2\", \"builder_9cda2f8c21edca8a77ce5edebdfeeced1c5c1bb5bdbdcfdc91d50b975e168f53_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-62-jhhu\"], \"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\": [\"5681-01e7fd1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612783533150037",
"status": "COMPLETED",
"status_changed_ts": "1612786610728617",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180379",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c3bf31a8138beb96423a292f0058db5c91d1f1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021297674758778672",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855867612793665648/+/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:519a353f1f9f1010",
"user_agent:luci-scheduler"
],
"updated_ts": "1612786610734180",
"url": "https://ci.chromium.org/b/8855867612793665648",
"utcnow_ts": "1612786612479706"
}
}
[12:16:53.444] Invocation finished in 51m24.308914849s with status SUCCEEDED