[01:49:32.127] New invocation is queued and will start shortly
[01:49:33.271] Starting the invocation (attempt 1)
[01:49:33.325] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:49:33.325] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:49:33.325] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027403907174986752",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9027403907174986752",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"gitiles_ref:refs/heads/master"
]
}
[01:49:34.380] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606960173423317",
"id": "8861973845151216768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606960174256131",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178283",
"builder:Linux Builder (dbg)",
"buildset:commit/git/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027403907174986752",
"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/8861973845151216768/+/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": "1606960174256224",
"url": "https://ci.chromium.org/b/8861973845151216768",
"utcnow_ts": "1606960174369148"
}
}
[01:49:34.380] Task URL: https://ci.chromium.org/b/8861973845151216768
[01:49:34.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:2:0) after 1m0s
[01:50:01.934] Received PubSub notification, asking Buildbucket for the build status
[01:50:02.061] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:34.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:2:0)
[01:50:34.452] Timer tick, asking Buildbucket for the build status
[01:50:34.633] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:4:0) after 1m0s
[01:51:34.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:4:0)
[01:51:34.698] Timer tick, asking Buildbucket for the build status
[01:51:34.865] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:34.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:5:0) after 1m0s
[01:52:34.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:5:0)
[01:52:34.890] Timer tick, asking Buildbucket for the build status
[01:52:35.321] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:35.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:6:0) after 1m0s
[01:53:35.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:6:0)
[01:53:35.386] Timer tick, asking Buildbucket for the build status
[01:53:35.516] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:7:0) after 1m0s
[01:54:35.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:7:0)
[01:54:35.575] Timer tick, asking Buildbucket for the build status
[01:54:35.697] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:35.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:8:0) after 1m0s
[01:55:35.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:8:0)
[01:55:35.714] Timer tick, asking Buildbucket for the build status
[01:55:35.919] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:35.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:9:0) after 1m0s
[01:56:35.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:9:0)
[01:56:35.970] Timer tick, asking Buildbucket for the build status
[01:56:36.061] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:36.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:10:0) after 1m0s
[01:57:36.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:10:0)
[01:57:36.179] Timer tick, asking Buildbucket for the build status
[01:57:37.278] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:37.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:11:0) after 1m0s
[01:58:37.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:11:0)
[01:58:37.354] Timer tick, asking Buildbucket for the build status
[01:58:37.567] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:37.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:12:0) after 1m0s
[01:59:37.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:12:0)
[01:59:37.666] Timer tick, asking Buildbucket for the build status
[01:59:37.851] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:37.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:13:0) after 1m0s
[02:00:37.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:13:0)
[02:00:37.852] Timer tick, asking Buildbucket for the build status
[02:00:37.944] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:37.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:14:0) after 1m0s
[02:01:37.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:14:0)
[02:01:37.954] Timer tick, asking Buildbucket for the build status
[02:01:38.015] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:38.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:15:0) after 1m0s
[02:02:38.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:15:0)
[02:02:38.048] Timer tick, asking Buildbucket for the build status
[02:02:38.131] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:38.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:16:0) after 1m0s
[02:03:38.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:16:0)
[02:03:38.152] Timer tick, asking Buildbucket for the build status
[02:03:38.508] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:38.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:17:0) after 1m0s
[02:04:38.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:17:0)
[02:04:38.540] Timer tick, asking Buildbucket for the build status
[02:04:38.624] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:38.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:18:0) after 1m0s
[02:05:38.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:18:0)
[02:05:38.676] Timer tick, asking Buildbucket for the build status
[02:05:38.919] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:38.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:19:0) after 1m0s
[02:06:38.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:19:0)
[02:06:38.992] Timer tick, asking Buildbucket for the build status
[02:06:39.085] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:39.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:20:0) after 1m0s
[02:07:39.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:20:0)
[02:07:39.118] Timer tick, asking Buildbucket for the build status
[02:07:40.127] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:40.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:21:0) after 1m0s
[02:08:40.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:21:0)
[02:08:40.177] Timer tick, asking Buildbucket for the build status
[02:08:40.452] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:40.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:22:0) after 1m0s
[02:09:40.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:22:0)
[02:09:40.538] Timer tick, asking Buildbucket for the build status
[02:09:40.685] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:23:0) after 1m0s
[02:10:40.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:23:0)
[02:10:40.780] Timer tick, asking Buildbucket for the build status
[02:10:40.867] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:40.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:24:0) after 1m0s
[02:11:40.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:24:0)
[02:11:40.903] Timer tick, asking Buildbucket for the build status
[02:11:41.772] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:41.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:25:0) after 1m0s
[02:12:41.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:25:0)
[02:12:41.833] Timer tick, asking Buildbucket for the build status
[02:12:42.174] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:26:0) after 1m0s
[02:13:42.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:26:0)
[02:13:42.232] Timer tick, asking Buildbucket for the build status
[02:13:42.290] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:42.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:27:0) after 1m0s
[02:14:42.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:27:0)
[02:14:42.323] Timer tick, asking Buildbucket for the build status
[02:14:42.504] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:42.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:28:0) after 1m0s
[02:15:42.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:28:0)
[02:15:42.556] Timer tick, asking Buildbucket for the build status
[02:15:42.635] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:42.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:29:0) after 1m0s
[02:16:42.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:29:0)
[02:16:42.677] Timer tick, asking Buildbucket for the build status
[02:16:42.736] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:42.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:30:0) after 1m0s
[02:17:42.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:30:0)
[02:17:42.727] Timer tick, asking Buildbucket for the build status
[02:17:42.826] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:42.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:31:0) after 1m0s
[02:18:42.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:31:0)
[02:18:42.854] Timer tick, asking Buildbucket for the build status
[02:18:42.975] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:42.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:32:0) after 1m0s
[02:19:43.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:32:0)
[02:19:43.026] Timer tick, asking Buildbucket for the build status
[02:19:43.596] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:43.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:33:0) after 1m0s
[02:20:43.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:33:0)
[02:20:43.617] Timer tick, asking Buildbucket for the build status
[02:20:43.716] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:43.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:34:0) after 1m0s
[02:21:43.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:34:0)
[02:21:43.738] Timer tick, asking Buildbucket for the build status
[02:21:43.940] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:43.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:35:0) after 1m0s
[02:22:43.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:35:0)
[02:22:43.999] Timer tick, asking Buildbucket for the build status
[02:22:44.080] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:44.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:36:0) after 1m0s
[02:23:44.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:36:0)
[02:23:44.154] Timer tick, asking Buildbucket for the build status
[02:23:44.288] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:44.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:37:0) after 1m0s
[02:24:44.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:37:0)
[02:24:44.273] Timer tick, asking Buildbucket for the build status
[02:24:45.152] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:45.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:38:0) after 1m0s
[02:25:45.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:38:0)
[02:25:45.172] Timer tick, asking Buildbucket for the build status
[02:25:45.614] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:45.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:39:0) after 1m0s
[02:26:45.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:39:0)
[02:26:45.672] Timer tick, asking Buildbucket for the build status
[02:26:45.735] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:45.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:40:0) after 1m0s
[02:27:45.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:40:0)
[02:27:45.801] Timer tick, asking Buildbucket for the build status
[02:27:46.037] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:46.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:41:0) after 1m0s
[02:28:46.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:41:0)
[02:28:46.157] Timer tick, asking Buildbucket for the build status
[02:28:46.279] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:46.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:42:0) after 1m0s
[02:29:46.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:42:0)
[02:29:46.313] Timer tick, asking Buildbucket for the build status
[02:29:46.479] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:46.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:43:0) after 1m0s
[02:30:46.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:43:0)
[02:30:46.537] Timer tick, asking Buildbucket for the build status
[02:30:46.647] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:46.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:44:0) after 1m0s
[02:31:46.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:44:0)
[02:31:46.706] Timer tick, asking Buildbucket for the build status
[02:31:46.775] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:46.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:45:0) after 1m0s
[02:32:46.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:45:0)
[02:32:46.788] Timer tick, asking Buildbucket for the build status
[02:32:46.853] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:46.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:46:0) after 1m0s
[02:33:46.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:46:0)
[02:33:46.903] Timer tick, asking Buildbucket for the build status
[02:33:47.125] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:47.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:47:0) after 1m0s
[02:34:47.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:47:0)
[02:34:47.140] Timer tick, asking Buildbucket for the build status
[02:34:47.328] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:47.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:48:0) after 1m0s
[02:35:47.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:48:0)
[02:35:47.414] Timer tick, asking Buildbucket for the build status
[02:35:47.562] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:47.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:49:0) after 1m0s
[02:36:47.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:49:0)
[02:36:47.613] Timer tick, asking Buildbucket for the build status
[02:36:47.786] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:47.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:50:0) after 1m0s
[02:37:47.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:50:0)
[02:37:47.837] Timer tick, asking Buildbucket for the build status
[02:37:47.946] Build 8861973845151216768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:47.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027403907174986752:51:0) after 1m0s
[02:38:02.749] Received PubSub notification, asking Buildbucket for the build status
[02:38:03.146] Build 8861973845151216768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:38:03.149] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606963081853617",
"created_by": "project:chromium",
"created_ts": "1606960173423317",
"id": "8861973845151216768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\"}}",
"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\": \"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\", \"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-97-ly7u\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178283, \"got_angle_revision\": \"8797714c4a78082270473e4b4bed18b4a60f6245\", \"got_dawn_revision\": \"429a12542f160a36d87c1daa6c3102bce072207e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\", \"got_revision_cp\": \"refs/heads/master@{#833097}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"95ffe036632c5de2e52a01d243e945a1123c91a2\", \"got_v8_revision\": \"252a9ed08d1203226b951518a5ec1113a22b362f\", \"got_v8_revision_cp\": \"refs/heads/8.9.76@{#1}\", \"got_webrtc_revision\": \"b6e840c0368f94366ad7f2c554d84e1d14f36ad4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32745}\", \"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\": \"352838530e6ae6bec6abc1ddc30afb8cef2d1a93\", \"swarm_hashes_refs/heads/master(at){#833097}_without_patch\": {\"absl_hardening_tests\": \"2bf10a8b07b0bc3c291bbce3a1f9d68841567076\", \"accessibility_unittests\": \"1cd8f7900f372ebe699d819fe524def854b65d28\", \"angle_unittests\": \"1bc546077156000049aa1d2472464dadb9b275f2\", \"app_shell_unittests\": \"5006840eb5af0ec35babd416f8122b97999e76b5\", \"aura_unittests\": \"9578427ef0e74c9999d65cd02c7edf7dffe9cbec\", \"base_unittests\": \"63732ea6d157ee609c92658809f42462d1074122\", \"base_util_unittests\": \"42e9996601fbb66ff6047cd74dacc739e95e8a65\", \"blink_common_unittests\": \"600d6a6e6d8122d1793b87daea74c448ab189508\", \"blink_fuzzer_unittests\": \"b3a93c3b2c1889ad9b5d305125f378563ed0f3d0\", \"blink_heap_unittests\": \"b1e62b2d1793aa5c81454fff3b3dd1c19e580c20\", \"blink_platform_unittests\": \"98c3e39f86973d6907530c2cb1804c5655f5180b\", \"blink_python_tests\": \"4060c36c6d312e2d536ee5d715520f24b81f6766\", \"blink_unittests\": \"e8faa757164b397df2647c6baf30cdcee8c67fba\", \"blink_web_tests\": \"4b2d748b80741ff487c2cf7b7948ba27222df512\", \"boringssl_crypto_tests\": \"21f1d185c4ae67253120e73f5de88ac1f40a53e0\", \"boringssl_ssl_tests\": \"7b46bcf97f3d8f0eaa652bdf0bf7b1f8653cfbca\", \"browser_tests\": \"18f59a2d5851cc994ea150aafb7f07b1b000f3a0\", \"capture_unittests\": \"ce2792a639d80101bd1e8bdca334a5c400ecd48a\", \"cast_unittests\": \"a9cbfbac5be53fffe54400407c131718cfd3fcc0\", \"cc_unittests\": \"85758dc7a4eb5b18854a538107870f0bec540492\", \"chrome_app_unittests\": \"734265ba65ea8e9f18fc2db7389ce11b44c2a6c1\", \"chromedriver_unittests\": \"b2ba530052a9687b4f6c7879154c151d99576dbe\", \"components_browsertests\": \"21bc3915f8fb41810c7713a9398bd664a24ffc57\", \"components_unittests\": \"1e10bb88710229ca2cc8a6aab68b644f1b5a2f38\", \"compositor_unittests\": \"10bb207144a54a0fd9542a8dea719cdc8ed8aee3\", \"content_browsertests\": \"6c1c25ffa55ee98d24ed564d3e7e2f4fd9ed233f\", \"content_shell_crash_test\": \"345be2ab16eaaed5b8daf7cc4feef5d39a32421c\", \"content_unittests\": \"b8de7f66ffce620c6265952fb8aa6c2e0f0a56e0\", \"crashpad_tests\": \"0c4e8d56b2f1b9649e3ef005eb34a6f328e53826\", \"cronet_tests\": \"c143f4736ae269cd5c9c42ff31f34ef27efa23eb\", \"cronet_unittests\": \"32764d59bdb347fab97fa844e84c6cc2a4c19fa8\", \"crypto_unittests\": \"86234f2660478eb0ba574cdbed8b44126a75d23f\", \"dbus_unittests\": \"3bcb43b1c0b86e57deaa77adc93450f562fe7c5c\", \"device_unittests\": \"0d81ef35e1fbd69f3f0d5dd4cdc58f4ab11885c8\", \"display_unittests\": \"b8489c7d46f16794b106d5733e6ed2dbad253af5\", \"events_unittests\": \"866e6ac1c130c0c4052b35530f3a029ffdd562c7\", \"extension_docserver_python_unittests\": \"499e6f5b4e026c27006c64d4f4af27a3b06ac197\", \"extensions_browsertests\": \"15691afcf0874290d046da94ed5081fff5e0f4ec\", \"extensions_unittests\": \"361c2293f9ad20f88578a4ece29046268afb2599\", \"filesystem_service_unittests\": \"9832cb6dc4eeb4d3b6889df48b5d39a8b3af432d\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"fe11565938f89447941f64e69c71c96734629209\", \"gfx_unittests\": \"458f6523f65837fff71c53f595cf74dc20a34232\", \"gin_unittests\": \"311cae696961bcfdc3582c6cb998d22aa4677fa0\", \"google_apis_unittests\": \"797e35505af905662a20228783826d2dc8751e67\", \"gpu_unittests\": \"41c1e6152ea27c03dd6d5bb0eaffbdfea44bc7b3\", \"grit_python_unittests\": \"0afe932bb293928849622f4855bf5364fc3d1290\", \"gwp_asan_unittests\": \"22bbfd9a078fb675624cb456f8cc9339e2427fc9\", \"headless_browsertests\": \"2531105cededf3b4f89f0c519d4abd483101e2bb\", \"headless_unittests\": \"5fa2b08cd23634e6a3f9a9e7d3aac591dae7b970\", \"interactive_ui_tests\": \"dd8e9211e21ff98b1c02047937d313ef4bde7c25\", \"ipc_tests\": \"12eec99b04cdc0b911c28d6ab00579cf4de1f13d\", \"jingle_unittests\": \"4cf1665f37689e5c9f621b622b84cca82e79bd3c\", \"latency_unittests\": \"5a420e01f622dbe2b678c88b888747d6d1703e94\", \"libjingle_xmpp_unittests\": \"4e2370bcaf12934aeaff38bc6897a4e3a366e21e\", \"liburlpattern_unittests\": \"00ca537b8ba015f192ef2dda073994894143e063\", \"media_blink_unittests\": \"07682aebe936de7d18f3c1284c8cf25585ce1b13\", \"media_unittests\": \"3f0e44a16e26339cdf7a74ecb3f0ef55034a36ec\", \"message_center_unittests\": \"c466615e79fb8913f434d82ebcc35db202e06b86\", \"metrics_python_tests\": \"533f143ddf6d8f88450644d86dd6fe4877902083\", \"midi_unittests\": \"8563435ce191c640d2d6f09bf35364103a94a051\", \"mojo_core_unittests\": \"731856a05ad118c293f8213af0e7197acda4f1f2\", \"mojo_unittests\": \"e2dd126c828ea19eb6ccb6a3f968be20e54547f0\", \"nacl_helper_nonsfi_unittests\": \"b1862669af96c9e969d203369e967264255947b3\", \"nacl_loader_unittests\": \"2a41d4da7ebc5b9f84abd41bf7e8684245c60e30\", \"native_theme_unittests\": \"f885a16fa9ee8859d13a963cd9928f4bcef18811\", \"net_unittests\": \"1a9243a532037355dc247213005525dc16235f18\", \"openscreen_unittests\": \"2f12159c229bbcc5c15ccc05bf7942f2ef9244f2\", \"pdf_unittests\": \"264a53465a10dd4182266b6aff594ef459775134\", \"perfetto_unittests\": \"693b19b9ee274c995efe8e40aa82e6f20c81cb13\", \"ppapi_unittests\": \"709a1ba38ea18356d185bf665e83d348ff279e63\", \"printing_unittests\": \"e6355241d8e6f4334cdbb1d78fd8709a93f1616b\", \"remoting_unittests\": \"015a805f5459ef2d78584fc5178ffde10408d6b5\", \"sandbox_linux_unittests\": \"7a5bd7d4029e10a2ab87e726562eb89a76cb58a6\", \"service_manager_unittests\": \"ddd4100ea25e2d543b24c71c410ac52ff2099cb6\", \"services_unittests\": \"7018fdedb194418bde11370f20be6d29bddc9023\", \"shell_dialogs_unittests\": \"a38e92c41e492db49961d525948e66072220602c\", \"skia_unittests\": \"40a5792d73806918f594461c7406f73bdec69d7f\", \"snapshot_unittests\": \"e32905e105b87187f54cf16443bd774a7a2cd842\", \"sql_unittests\": \"a9f0640ce3b0f4f12da6036a39073af79ceb76e3\", \"storage_unittests\": \"d750abcd59a7ef960a63d0852441292731f83863\", \"sync_integration_tests\": \"db2ad5545bb30c90269d206c4d04854971ee5844\", \"telemetry_gpu_unittests\": \"a9d0218c5153fa9fb05d689443ccf64d1272d6ff\", \"telemetry_perf_unittests\": \"8a0cefd45a524e58a23048ecf87e0f52fac82ed1\", \"telemetry_unittests\": \"929bf3bdb38cf3d365ac57e2a9e60310c8e0f2be\", \"traffic_annotation_auditor_unittests\": \"65b9e4837d7fc28681d4751ae413b2601f1865bf\", \"ui_base_unittests\": \"06a30eaa95b3b8ec479b14bb73715f849406a5a8\", \"ui_touch_selection_unittests\": \"97a14db5ac031a5a87a46ff9d870ac747af6f19d\", \"unit_tests\": \"8af45d833496449c07466f250e1c53bb4f602fc2\", \"url_unittests\": \"8db49b8531f50099fc25a8e99e35977061fce9ad\", \"views_perftests\": \"8461e1b182d06fa1a43af58a0b49e7a0c8a3b889\", \"views_unittests\": \"c3f25937df7bbd5ab05613b3e4230be83cf52069\", \"viz_unittests\": \"6caf8c3a0e3679e5b33f4107cd3d58f51934604a\", \"vr_common_unittests\": \"8dff506391678f920490f236788f13b4722803ff\", \"vr_pixeltests\": \"95178162898770601b773d5a045306639f75c1a7\", \"webdriver_wpt_tests\": \"7e07706cb433f0684a5cc097dedf286545e07845\", \"weblayer_browsertests\": \"75c49a9f52fecc7c79473e6486df4c7261b6ff94\", \"weblayer_unittests\": \"dcdaa3e4300166228f8ec450674a0c57ab1c7db7\", \"wm_unittests\": \"d3662fbebebc5bc189fb63d30d5a9e27d8f78437\", \"wtf_unittests\": \"b92122d880c192c050166d12580ec4fd90c89c10\", \"x11_unittests\": \"31e9caaa994fad05f4528e8dc8cbe5f5f00d496c\", \"xr_browser_tests\": \"e6d925c4670ecdb6266b03be6832803efd52ade8\", \"zlib_unittests\": \"4076e04c8cb12006c35f4411c17093c79da673cd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_11b57e6d03428c2faa53796866d496d474313651f92f95ab80780c64b3558ac7_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_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-97-ly7u\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606960200684985",
"status": "COMPLETED",
"status_changed_ts": "1606963082397423",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178283",
"builder:Linux Builder (dbg)",
"buildset:commit/git/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/352838530e6ae6bec6abc1ddc30afb8cef2d1a93",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027403907174986752",
"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/8861973845151216768/+/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:503f1bddd8ee7310",
"user_agent:luci-scheduler"
],
"updated_ts": "1606963082402083",
"url": "https://ci.chromium.org/b/8861973845151216768",
"utcnow_ts": "1606963083066028"
}
}
[02:38:03.149] Invocation finished in 48m31.040260938s with status SUCCEEDED