[22:23:28.547] New invocation is queued and will start shortly
[22:23:29.828] Starting the invocation (attempt 1)
[22:23:29.863] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:23:29.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:23:29.863] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054686558215389760",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a95e585ce6b31ce7fd56108e42f47f6c2174974f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054686558215389760",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"gitiles_ref:refs/heads/master"
]
}
[22:23:30.828] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580941410233530",
"id": "8889256495781368336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a95e585ce6b31ce7fd56108e42f47f6c2174974f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580941410684330",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168273",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054686558215389760",
"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/8889256495781368336/+/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": "1580941410684427",
"url": "https://ci.chromium.org/b/8889256495781368336",
"utcnow_ts": "1580941410822234"
}
}
[22:23:30.828] Task URL: https://ci.chromium.org/b/8889256495781368336
[22:23:30.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:2:0) after 1m0s
[22:24:30.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:2:0)
[22:24:30.940] Timer tick, asking Buildbucket for the build status
[22:24:31.301] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:31.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:3:0) after 1m0s
[22:25:31.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:3:0)
[22:25:31.346] Timer tick, asking Buildbucket for the build status
[22:25:31.496] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:31.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:4:0) after 1m0s
[22:26:31.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:4:0)
[22:26:31.526] Timer tick, asking Buildbucket for the build status
[22:26:31.738] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:31.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:5:0) after 1m0s
[22:27:31.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:5:0)
[22:27:31.822] Timer tick, asking Buildbucket for the build status
[22:27:32.148] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:32.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:6:0) after 1m0s
[22:28:32.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:6:0)
[22:28:32.163] Timer tick, asking Buildbucket for the build status
[22:28:32.629] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:32.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:7:0) after 1m0s
[22:29:32.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:7:0)
[22:29:32.699] Timer tick, asking Buildbucket for the build status
[22:29:33.468] Build 8889256495781368336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:33.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:8:0) after 1m0s
[22:30:03.610] Received PubSub notification, asking Buildbucket for the build status
[22:30:03.795] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:33.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:8:0)
[22:30:33.493] Timer tick, asking Buildbucket for the build status
[22:30:33.871] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:33.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:10:0) after 1m0s
[22:31:33.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:10:0)
[22:31:33.924] Timer tick, asking Buildbucket for the build status
[22:31:34.348] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:11:0) after 1m0s
[22:32:34.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:11:0)
[22:32:34.380] Timer tick, asking Buildbucket for the build status
[22:32:34.568] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:34.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:12:0) after 1m0s
[22:33:34.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:12:0)
[22:33:34.644] Timer tick, asking Buildbucket for the build status
[22:33:35.577] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:35.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:13:0) after 1m0s
[22:34:35.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:13:0)
[22:34:35.772] Timer tick, asking Buildbucket for the build status
[22:34:35.951] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:35.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:14:0) after 1m0s
[22:35:36.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:14:0)
[22:35:36.011] Timer tick, asking Buildbucket for the build status
[22:35:36.176] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:36.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:15:0) after 1m0s
[22:36:36.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:15:0)
[22:36:36.167] Timer tick, asking Buildbucket for the build status
[22:36:36.487] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:16:0) after 1m0s
[22:37:36.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:16:0)
[22:37:36.617] Timer tick, asking Buildbucket for the build status
[22:37:36.791] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:36.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:17:0) after 1m0s
[22:38:36.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:17:0)
[22:38:36.950] Timer tick, asking Buildbucket for the build status
[22:38:37.137] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:37.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:18:0) after 1m0s
[22:39:37.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:18:0)
[22:39:37.169] Timer tick, asking Buildbucket for the build status
[22:39:37.469] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:37.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:19:0) after 1m0s
[22:40:37.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:19:0)
[22:40:37.620] Timer tick, asking Buildbucket for the build status
[22:40:38.333] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:38.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:20:0) after 1m0s
[22:41:38.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:20:0)
[22:41:38.623] Timer tick, asking Buildbucket for the build status
[22:41:39.057] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:39.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:21:0) after 1m0s
[22:42:39.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:21:0)
[22:42:39.218] Timer tick, asking Buildbucket for the build status
[22:42:39.537] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:39.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:22:0) after 1m0s
[22:43:39.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:22:0)
[22:43:39.645] Timer tick, asking Buildbucket for the build status
[22:43:39.871] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:39.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:23:0) after 1m0s
[22:44:40.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:23:0)
[22:44:40.048] Timer tick, asking Buildbucket for the build status
[22:44:40.402] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:40.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:24:0) after 1m0s
[22:45:40.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:24:0)
[22:45:40.544] Timer tick, asking Buildbucket for the build status
[22:45:40.767] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:40.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:25:0) after 1m0s
[22:46:40.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:25:0)
[22:46:40.829] Timer tick, asking Buildbucket for the build status
[22:46:40.991] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:40.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:26:0) after 1m0s
[22:47:41.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:26:0)
[22:47:41.106] Timer tick, asking Buildbucket for the build status
[22:47:41.921] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:41.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:27:0) after 1m0s
[22:48:42.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:27:0)
[22:48:42.093] Timer tick, asking Buildbucket for the build status
[22:48:42.261] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:42.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:28:0) after 1m0s
[22:49:42.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:28:0)
[22:49:42.293] Timer tick, asking Buildbucket for the build status
[22:49:42.640] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:42.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:29:0) after 1m0s
[22:50:42.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:29:0)
[22:50:42.659] Timer tick, asking Buildbucket for the build status
[22:50:42.835] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:42.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:30:0) after 1m0s
[22:51:42.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:30:0)
[22:51:42.864] Timer tick, asking Buildbucket for the build status
[22:51:44.273] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:44.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:31:0) after 1m0s
[22:52:44.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:31:0)
[22:52:44.281] Timer tick, asking Buildbucket for the build status
[22:52:44.466] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:44.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:32:0) after 1m0s
[22:53:44.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:32:0)
[22:53:44.565] Timer tick, asking Buildbucket for the build status
[22:53:44.849] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:33:0) after 1m0s
[22:54:45.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:33:0)
[22:54:45.021] Timer tick, asking Buildbucket for the build status
[22:54:45.221] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:45.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:34:0) after 1m0s
[22:55:45.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:34:0)
[22:55:45.352] Timer tick, asking Buildbucket for the build status
[22:55:45.629] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:45.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:35:0) after 1m0s
[22:56:45.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:35:0)
[22:56:45.641] Timer tick, asking Buildbucket for the build status
[22:56:45.998] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:45.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:36:0) after 1m0s
[22:57:46.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:36:0)
[22:57:46.025] Timer tick, asking Buildbucket for the build status
[22:57:46.272] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:46.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:37:0) after 1m0s
[22:58:46.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:37:0)
[22:58:46.602] Timer tick, asking Buildbucket for the build status
[22:58:46.764] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:38:0) after 1m0s
[22:59:46.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:38:0)
[22:59:46.793] Timer tick, asking Buildbucket for the build status
[22:59:46.948] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:46.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:39:0) after 1m0s
[23:00:46.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:39:0)
[23:00:46.975] Timer tick, asking Buildbucket for the build status
[23:00:47.589] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:47.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:40:0) after 1m0s
[23:01:47.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:40:0)
[23:01:47.640] Timer tick, asking Buildbucket for the build status
[23:01:47.824] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:47.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:41:0) after 1m0s
[23:02:47.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:41:0)
[23:02:47.829] Timer tick, asking Buildbucket for the build status
[23:02:47.978] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:47.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:42:0) after 1m0s
[23:03:48.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:42:0)
[23:03:48.000] Timer tick, asking Buildbucket for the build status
[23:03:48.208] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:48.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:43:0) after 1m0s
[23:04:48.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:43:0)
[23:04:48.435] Timer tick, asking Buildbucket for the build status
[23:04:48.654] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:44:0) after 1m0s
[23:05:48.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:44:0)
[23:05:48.804] Timer tick, asking Buildbucket for the build status
[23:05:50.568] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:50.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:45:0) after 1m0s
[23:06:50.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:45:0)
[23:06:50.655] Timer tick, asking Buildbucket for the build status
[23:06:51.014] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:51.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:46:0) after 1m0s
[23:07:51.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:46:0)
[23:07:51.075] Timer tick, asking Buildbucket for the build status
[23:07:51.253] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:51.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:47:0) after 1m0s
[23:08:51.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:47:0)
[23:08:51.274] Timer tick, asking Buildbucket for the build status
[23:08:51.451] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:51.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:48:0) after 1m0s
[23:09:51.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:48:0)
[23:09:51.491] Timer tick, asking Buildbucket for the build status
[23:09:51.842] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:51.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:49:0) after 1m0s
[23:10:51.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:49:0)
[23:10:51.962] Timer tick, asking Buildbucket for the build status
[23:10:52.440] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:52.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:50:0) after 1m0s
[23:11:52.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:50:0)
[23:11:52.485] Timer tick, asking Buildbucket for the build status
[23:11:53.237] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:53.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:51:0) after 1m0s
[23:12:53.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:51:0)
[23:12:53.226] Timer tick, asking Buildbucket for the build status
[23:12:54.224] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:54.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:52:0) after 1m0s
[23:13:54.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:52:0)
[23:13:54.212] Timer tick, asking Buildbucket for the build status
[23:13:54.421] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:54.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:53:0) after 1m0s
[23:14:54.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:53:0)
[23:14:54.448] Timer tick, asking Buildbucket for the build status
[23:14:55.001] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:55.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:54:0) after 1m0s
[23:15:55.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:54:0)
[23:15:55.056] Timer tick, asking Buildbucket for the build status
[23:15:56.200] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:56.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:55:0) after 1m0s
[23:16:56.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:55:0)
[23:16:56.257] Timer tick, asking Buildbucket for the build status
[23:16:57.286] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:57.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:56:0) after 1m0s
[23:17:57.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:56:0)
[23:17:57.359] Timer tick, asking Buildbucket for the build status
[23:17:57.653] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:57:0) after 1m0s
[23:18:57.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:57:0)
[23:18:57.675] Timer tick, asking Buildbucket for the build status
[23:18:58.052] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:58.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:58:0) after 1m0s
[23:19:58.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:58:0)
[23:19:58.132] Timer tick, asking Buildbucket for the build status
[23:19:58.341] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:58.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:59:0) after 1m0s
[23:20:58.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:59:0)
[23:20:58.414] Timer tick, asking Buildbucket for the build status
[23:20:59.161] Build 8889256495781368336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:59.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054686558215389760:60:0) after 1m0s
[23:21:53.156] Received PubSub notification, asking Buildbucket for the build status
[23:21:53.320] Build 8889256495781368336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:21:53.321] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580944912403198",
"created_by": "project:chromium",
"created_ts": "1580941410233530",
"id": "8889256495781368336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a95e585ce6b31ce7fd56108e42f47f6c2174974f\"}}",
"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\"}, \"$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-104-1es9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168273, \"got_angle_revision\": \"a44d96dcd676fc7d446b41fb766caad9bdab9fda\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"a95e585ce6b31ce7fd56108e42f47f6c2174974f\", \"got_revision_cp\": \"refs/heads/master@{#738700}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8e8e1d0dd7292440b803b95bc0832589520f784d\", \"got_v8_revision\": \"4dc7c627a1ebc90c34cdb39c44015a83d924f4ee\", \"got_v8_revision_cp\": \"refs/heads/8.2.12@{#1}\", \"got_webrtc_revision\": \"02b17a5507ae6be7cb8775760627b79b7faba69c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30458}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a95e585ce6b31ce7fd56108e42f47f6c2174974f\", \"swarm_hashes_refs/heads/master(at){#738700}_without_patch\": {\"accessibility_unittests\": \"e2de245338778603875add82da1610002993d32e\", \"angle_unittests\": \"e6a2e07d5c12067b71ac162aef35b88cfe7d948a\", \"app_shell_unittests\": \"fae5b59fd4096959cd9f88627c816c5ddadcd7a1\", \"aura_unittests\": \"b73af208343b98598b83c198a05fe9e30a50fd72\", \"base_unittests\": \"db6689ca3cd271159268dad6356854651e9165d4\", \"base_util_unittests\": \"1fb24bf247e4c9ff5abdd7750c9e5d4ba74014d0\", \"blink_common_unittests\": \"44a83bf077bd2ba3b1f91b89292b12c51e422765\", \"blink_fuzzer_unittests\": \"d9a31a15c369828164a3738f7ac261148f403dd7\", \"blink_heap_unittests\": \"eabdc970d27dd6c965adb4e94bbeb552d16da598\", \"blink_platform_unittests\": \"d02281d07319c9aebe988b7c873cde35cf0a0ebd\", \"blink_python_tests\": \"ab68f28bb8f8a88ac25d3cd36b90a67a54bac2b1\", \"blink_unittests\": \"05fcb19f217105033affc58269c5299e3e27b935\", \"blink_web_tests\": \"7baf5b1612713ce54161cbe6f7d104662c74ae36\", \"boringssl_crypto_tests\": \"59ffb3dea1f049cbd1273457caef906771add2ec\", \"boringssl_ssl_tests\": \"9d93285a4117d25760a190a2546ea756631a04f4\", \"browser_tests\": \"a2b201af50a6da0f4959fed4707be174f2317c03\", \"cacheinvalidation_unittests\": \"6380104f37c3571d0d5b29db58ed9a95e25d4918\", \"capture_unittests\": \"5c8f1930321a0d2ee91d4978624994235a23b2ab\", \"cast_unittests\": \"a9ca1c0cfc6a8bae9c0f1a13c357f89fe0c2c59d\", \"cc_unittests\": \"964c8fd8768f9685c1290402a24f9dc82b45adea\", \"chrome_app_unittests\": \"5c10a6f9c13accbccb37561c672a7d2716f4a2ff\", \"chromedriver_unittests\": \"617053530b9c472d3501138c30b9af0774b52704\", \"components_browsertests\": \"e0cd5aebd26d7307d1267141af2dc2c8dd13a7f6\", \"components_unittests\": \"9e2ab55d372a5b9b2ccba2cbca8f56402e13b0a9\", \"compositor_unittests\": \"e5750b255389cc5ec69044ccf8d1c771a5be1ed3\", \"content_browsertests\": \"f38decf47c7f4fab57a727f9d44638b8cbe9dcf1\", \"content_shell_crash_test\": \"e79382568a4e7adb370e58ac69f5ffbb07caa02a\", \"content_unittests\": \"f4198bdc19785e09bbd270846df3b273625acc36\", \"crashpad_tests\": \"97dca390746ab8567b9524558b89a33e0117cc59\", \"cronet_tests\": \"43ad178ed4705e7f6c89b175ca15d6cbdb5a5187\", \"cronet_unittests\": \"d2cbd25444ae962340b98683ba6d897d3fb006d2\", \"crypto_unittests\": \"11dde5e8a63f1a3f08858116887b4741e24d9071\", \"dbus_unittests\": \"9ca9077bb30479a16583f3ad19e7871f79bd83b8\", \"device_unittests\": \"bc972699134780fbb1675aa568ed1495a4b76531\", \"display_unittests\": \"5cc31e8bf89686d9ffcfdc7a05275c8247bba18b\", \"events_unittests\": \"9b379bda02dbe9e1fc69c133fa7b999cecedbf7a\", \"extensions_browsertests\": \"1bda68d61d541f5bb53693834a9ff197ed9d5b61\", \"extensions_unittests\": \"b7db84aab85e65674505362ec22999c720f565ec\", \"filesystem_service_unittests\": \"0b01fcc33be9dc424593c044c839c7f7662da738\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"d7768f8f5b72ea440ff7e5af5267d3a0005e7883\", \"gfx_unittests\": \"a0f2d8eed8cd4fcd0c884627eb4b99d804c96011\", \"gin_unittests\": \"7eebd351168cd96c81b921053efa297f52b4591e\", \"google_apis_unittests\": \"e6c435d17cebe5c47935c1f671541338f4f8ae5e\", \"gpu_unittests\": \"6960fb80260c631911b6b788132889f7d2090199\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"8fc6d56be132770b2ee265dbeddb3b544a9642a0\", \"headless_browsertests\": \"0bc9fc27025bf837f1f42e2e7b1e5e49244d144d\", \"headless_unittests\": \"4ba34f7580fd46b0a0c0687d86e483fe6445dcf4\", \"interactive_ui_tests\": \"d590d8a36487c44691bc4963df59fa07fc4114c9\", \"ipc_tests\": \"5dcd2a9028d4c558e52cdd0490fde05ad9015584\", \"jingle_unittests\": \"80eb19565a3095209cdd09381b3a456d208b3bbf\", \"latency_unittests\": \"3a45aacc9575df4fdcae70f02f629d36754f95b0\", \"libjingle_xmpp_unittests\": \"02ff42a8c9eba8b98bd390630bfd51bc99bb00fc\", \"media_blink_unittests\": \"ce83afe73328e0c6284c34dc66f1d3e7f778f7c1\", \"media_service_unittests\": \"2a6a0538b67bf2f53f427924bd4b3885e8e9269c\", \"media_unittests\": \"6452136438fc668991e698db5cb226506b3639fe\", \"message_center_unittests\": \"bbcfde4446fb601338439e990788ef5b84e96ee0\", \"metrics_python_tests\": \"c1294b4d7509ac5c276e39eb5c9c37ba455bb280\", \"midi_unittests\": \"0300237b144968e57853e02fe1cda46eec29617f\", \"mojo_core_unittests\": \"df61682da07ad1c046f0577d98fec4c0f422bc18\", \"mojo_unittests\": \"005e00cd473074c3bdbb5e9e736c2e7a459cbb60\", \"nacl_helper_nonsfi_unittests\": \"53cd259b7b1e63cfce3b0db5e6fbd19310b9abc2\", \"nacl_loader_unittests\": \"73c02e792fdda7f3061cdbf02ae4df7ea443399d\", \"native_theme_unittests\": \"cad641b8a009fec24806071510b2eca015c1ecbf\", \"net_unittests\": \"35939673035d6732ed9cc40df56f2afc2dbcef76\", \"pdf_unittests\": \"9a90a4c7729af51224566305dc96561463250214\", \"perfetto_unittests\": \"977903dd56561d1d863119e8fe34709a9264e30b\", \"ppapi_unittests\": \"ffb95735f6fd8cc0e0f75c6ed35ea8fb246b9552\", \"printing_unittests\": \"829f28c9dff754cbc497eaa902d6f702098e3400\", \"remoting_unittests\": \"49ec8bbf4abf8c81be6b187fd6096579eb89805f\", \"sandbox_linux_unittests\": \"8fd52c5d27e8e0be6081b7efa31224dae8cb44f6\", \"service_manager_unittests\": \"6b83fc0bf853ee16b070d0dbd6338d93d57d56e7\", \"services_unittests\": \"66370e1c31247a11694925c07b6350dc6327f264\", \"shell_dialogs_unittests\": \"6e18b2cecbc91d97b6a6b9efe05434feadb6bdd4\", \"skia_unittests\": \"1970be47cac4cc36e9e2bfaadf1669a96cb4116d\", \"snapshot_unittests\": \"46457345118d9fda46692e8a8c302afd72938802\", \"sql_unittests\": \"e0b85af04651f692556bb86f3d7c34732b893b77\", \"storage_unittests\": \"3455ad7246c7c0399fb0e43b60511d001c87b401\", \"sync_integration_tests\": \"74deab4356c748c4a72b3ca83ea0dbf4aa7fa0d4\", \"telemetry_gpu_unittests\": \"0a3f28952f1c31c742cfeec052e65c53e5b7a2a8\", \"telemetry_perf_unittests\": \"f6d6fa1ed537766654172daa38ff3bf9ff394d49\", \"telemetry_unittests\": \"e7ead6bd89b35a718e58d104b42701b286103a51\", \"traffic_annotation_auditor_unittests\": \"33fa11c76213c0b6c629d9a21a4555bae13eeca9\", \"ui_base_unittests\": \"53a123581cbfed370b4657d6bfaeb1885abfc69b\", \"ui_touch_selection_unittests\": \"a651fef4b8046aa99da01c30728af5e9113ea295\", \"unit_tests\": \"da66330bfda290db9d8c4dd2088fc4c69dd27d4a\", \"url_unittests\": \"34652ba7cca8da879ad7ab10b09f204ed0a12188\", \"views_perftests\": \"7668a414b680a99b627d38f4c7416ad92d278e9d\", \"views_unittests\": \"60930e1ff4ec82ac679a2e59a2d95bca134b05ec\", \"viz_unittests\": \"329f3035d36a2ab8e2a8653380025e8dc4622336\", \"vr_common_unittests\": \"34c4b726259cee7f6f50dfa6cbffa8b915e81b8f\", \"vr_pixeltests\": \"6a71e04d4c0facf2326e889b3b959574fe6dce97\", \"webdriver_wpt_tests\": \"6bc933c95dbde7e2253378f51c086b8b904cc46f\", \"weblayer_browsertests\": \"05db05538db95684005c43fb715a173cb47a4e12\", \"wm_unittests\": \"bac2702fcd28db09a6438f39e1249cba13e40ca7\", \"wtf_unittests\": \"d17ce118e225ff0acc5f9028a6c3528ef9cb6f47\", \"xr_browser_tests\": \"35b10a158393141c324d42e9860d4565cbdd40f5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_662609c3a18ad850d61ba5f58749e60478bc4d9d576475e0c738a1c9e2d8d890_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_86798dabf94f8387a70bc61df85c682f30176fee5c17d25bf53551dac0cf2cf7_v2\", \"builder_91dc5ce0f7d9a4ba8efbdbb6360d947a001f2754e92adddaf9400582bbdcce50_v2\", \"builder_cc8a16e85eefa617bab544f2f33977139159d8b8c3b7333fd512c64ffd131f2c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-104-1es9\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580941802847001",
"status": "COMPLETED",
"status_changed_ts": "1580944912698811",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168273",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a95e585ce6b31ce7fd56108e42f47f6c2174974f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054686558215389760",
"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/8889256495781368336/+/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:4a30450bc1cc8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1580944912704024",
"url": "https://ci.chromium.org/b/8889256495781368336",
"utcnow_ts": "1580944913308585"
}
}
[23:21:53.321] Invocation finished in 58m24.791975642s with status SUCCEEDED