[15:54:24.470] New invocation is queued and will start shortly
[15:54:25.643] Starting the invocation (attempt 1)
[15:54:25.692] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:54:25.692] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:54:25.692] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022458516213137840",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022458516213137840",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"gitiles_ref:refs/heads/master"
]
}
[15:54:26.905] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611676465783145",
"id": "8857028454173888576",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611676466613649",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179999",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022458516213137840",
"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/8857028454173888576/+/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": "1611676466613843",
"url": "https://ci.chromium.org/b/8857028454173888576",
"utcnow_ts": "1611676466857304"
}
}
[15:54:26.905] Task URL: https://ci.chromium.org/b/8857028454173888576
[15:54:26.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:2:0) after 1m0s
[15:54:35.333] Received PubSub notification, asking Buildbucket for the build status
[15:54:35.415] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:26.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:2:0)
[15:55:26.963] Timer tick, asking Buildbucket for the build status
[15:55:27.533] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:27.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:4:0) after 1m0s
[15:56:27.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:4:0)
[15:56:27.605] Timer tick, asking Buildbucket for the build status
[15:56:27.659] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:27.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:5:0) after 1m0s
[15:57:27.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:5:0)
[15:57:27.691] Timer tick, asking Buildbucket for the build status
[15:57:27.796] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:6:0) after 1m0s
[15:58:28.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:6:0)
[15:58:28.529] Timer tick, asking Buildbucket for the build status
[15:58:28.645] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:28.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:7:0) after 1m0s
[15:59:29.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:7:0)
[15:59:29.034] Timer tick, asking Buildbucket for the build status
[15:59:29.223] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:29.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:8:0) after 1m0s
[16:00:29.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:8:0)
[16:00:29.446] Timer tick, asking Buildbucket for the build status
[16:00:29.586] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:29.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:9:0) after 1m0s
[16:01:29.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:9:0)
[16:01:29.847] Timer tick, asking Buildbucket for the build status
[16:01:29.934] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:29.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:10:0) after 1m0s
[16:02:30.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:10:0)
[16:02:30.009] Timer tick, asking Buildbucket for the build status
[16:02:30.093] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:11:0) after 1m0s
[16:03:30.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:11:0)
[16:03:30.061] Timer tick, asking Buildbucket for the build status
[16:03:30.122] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:30.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:12:0) after 1m0s
[16:04:30.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:12:0)
[16:04:30.136] Timer tick, asking Buildbucket for the build status
[16:04:30.241] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:30.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:13:0) after 1m0s
[16:05:30.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:13:0)
[16:05:30.320] Timer tick, asking Buildbucket for the build status
[16:05:30.382] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:30.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:14:0) after 1m0s
[16:06:30.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:14:0)
[16:06:30.400] Timer tick, asking Buildbucket for the build status
[16:06:30.471] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:30.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:15:0) after 1m0s
[16:07:30.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:15:0)
[16:07:30.549] Timer tick, asking Buildbucket for the build status
[16:07:30.639] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:30.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:16:0) after 1m0s
[16:08:30.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:16:0)
[16:08:30.660] Timer tick, asking Buildbucket for the build status
[16:08:30.831] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:30.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:17:0) after 1m0s
[16:09:30.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:17:0)
[16:09:30.860] Timer tick, asking Buildbucket for the build status
[16:09:31.006] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:31.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:18:0) after 1m0s
[16:10:31.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:18:0)
[16:10:31.048] Timer tick, asking Buildbucket for the build status
[16:10:31.176] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:31.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:19:0) after 1m0s
[16:11:31.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:19:0)
[16:11:31.273] Timer tick, asking Buildbucket for the build status
[16:11:31.379] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:31.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:20:0) after 1m0s
[16:12:31.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:20:0)
[16:12:31.422] Timer tick, asking Buildbucket for the build status
[16:12:31.641] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:31.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:21:0) after 1m0s
[16:13:31.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:21:0)
[16:13:31.705] Timer tick, asking Buildbucket for the build status
[16:13:31.800] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:31.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:22:0) after 1m0s
[16:14:31.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:22:0)
[16:14:31.778] Timer tick, asking Buildbucket for the build status
[16:14:31.902] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:31.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:23:0) after 1m0s
[16:15:31.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:23:0)
[16:15:31.954] Timer tick, asking Buildbucket for the build status
[16:15:32.045] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:24:0) after 1m0s
[16:16:32.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:24:0)
[16:16:32.146] Timer tick, asking Buildbucket for the build status
[16:16:32.214] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:32.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:25:0) after 1m0s
[16:17:32.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:25:0)
[16:17:32.218] Timer tick, asking Buildbucket for the build status
[16:17:32.283] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:32.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:26:0) after 1m0s
[16:18:32.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:26:0)
[16:18:32.315] Timer tick, asking Buildbucket for the build status
[16:18:32.409] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:32.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:27:0) after 1m0s
[16:19:32.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:27:0)
[16:19:32.440] Timer tick, asking Buildbucket for the build status
[16:19:32.558] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:32.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:28:0) after 1m0s
[16:20:32.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:28:0)
[16:20:32.641] Timer tick, asking Buildbucket for the build status
[16:20:32.782] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:29:0) after 1m0s
[16:21:32.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:29:0)
[16:21:32.853] Timer tick, asking Buildbucket for the build status
[16:21:32.999] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:32.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:30:0) after 1m0s
[16:22:33.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:30:0)
[16:22:33.035] Timer tick, asking Buildbucket for the build status
[16:22:33.122] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:31:0) after 1m0s
[16:23:33.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:31:0)
[16:23:33.361] Timer tick, asking Buildbucket for the build status
[16:23:33.528] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:32:0) after 1m0s
[16:24:33.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:32:0)
[16:24:33.671] Timer tick, asking Buildbucket for the build status
[16:24:33.880] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:33.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:33:0) after 1m0s
[16:25:34.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:33:0)
[16:25:34.020] Timer tick, asking Buildbucket for the build status
[16:25:34.159] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:34.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:34:0) after 1m0s
[16:26:34.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:34:0)
[16:26:34.483] Timer tick, asking Buildbucket for the build status
[16:26:36.417] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:36.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:35:0) after 1m0s
[16:27:36.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:35:0)
[16:27:36.439] Timer tick, asking Buildbucket for the build status
[16:27:36.531] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:36.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:36:0) after 1m0s
[16:28:36.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:36:0)
[16:28:36.766] Timer tick, asking Buildbucket for the build status
[16:28:36.841] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:36.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:37:0) after 1m0s
[16:29:36.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:37:0)
[16:29:36.861] Timer tick, asking Buildbucket for the build status
[16:29:37.025] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:37.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:38:0) after 1m0s
[16:30:37.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:38:0)
[16:30:37.078] Timer tick, asking Buildbucket for the build status
[16:30:37.208] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:39:0) after 1m0s
[16:31:37.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:39:0)
[16:31:37.240] Timer tick, asking Buildbucket for the build status
[16:31:37.526] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:37.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:40:0) after 1m0s
[16:32:37.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:40:0)
[16:32:37.565] Timer tick, asking Buildbucket for the build status
[16:32:37.778] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:41:0) after 1m0s
[16:33:37.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:41:0)
[16:33:37.800] Timer tick, asking Buildbucket for the build status
[16:33:38.017] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:38.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:42:0) after 1m0s
[16:34:38.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:42:0)
[16:34:38.037] Timer tick, asking Buildbucket for the build status
[16:34:38.183] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:38.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:43:0) after 1m0s
[16:35:38.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:43:0)
[16:35:38.264] Timer tick, asking Buildbucket for the build status
[16:35:38.444] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:38.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:44:0) after 1m0s
[16:36:38.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:44:0)
[16:36:38.478] Timer tick, asking Buildbucket for the build status
[16:36:38.572] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:38.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:45:0) after 1m0s
[16:37:38.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:45:0)
[16:37:38.681] Timer tick, asking Buildbucket for the build status
[16:37:38.774] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:38.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:46:0) after 1m0s
[16:38:38.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:46:0)
[16:38:38.872] Timer tick, asking Buildbucket for the build status
[16:38:38.942] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:38.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:47:0) after 1m0s
[16:39:38.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:47:0)
[16:39:38.988] Timer tick, asking Buildbucket for the build status
[16:39:39.144] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:39.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:48:0) after 1m0s
[16:40:39.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:48:0)
[16:40:39.170] Timer tick, asking Buildbucket for the build status
[16:40:39.706] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:39.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:49:0) after 1m0s
[16:41:39.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:49:0)
[16:41:39.915] Timer tick, asking Buildbucket for the build status
[16:41:41.413] Build 8857028454173888576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:41.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022458516213137840:50:0) after 1m0s
[16:42:40.694] Received PubSub notification, asking Buildbucket for the build status
[16:42:41.018] Build 8857028454173888576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:42:41.018] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611679359085062",
"created_by": "project:chromium",
"created_ts": "1611676465783145",
"id": "8857028454173888576",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\"}}",
"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\": \"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\", \"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-72-9inl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179999, \"got_angle_revision\": \"9bbcd86ae719866273598c988709c7ec3d462e1d\", \"got_dawn_revision\": \"e0feccacafb0643fbaef8f807a9b76f1b9a97828\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\", \"got_revision_cp\": \"refs/heads/master@{#847175}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"ea1f7d10db1f22f3327f4c0bc690695bc1a73aa0\", \"got_v8_revision\": \"cb0390ea3f974ec4702166fb6ce4455c408b9bdf\", \"got_v8_revision_cp\": \"refs/heads/9.0.70@{#1}\", \"got_webrtc_revision\": \"4f3a2eba6b989f28045be92615bd3fb214a359cc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33071}\", \"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\": \"bedf32bc66cf6f9add51eaccf400de80d08eb4ac\", \"swarm_hashes_refs/heads/master(at){#847175}_without_patch\": {\"absl_hardening_tests\": \"b427d59c512fba71ea7fd411c5b71399d302d308\", \"accessibility_unittests\": \"cdd665da39d4d42e345de3c5752ade8d104ab642\", \"angle_unittests\": \"c8cb49a491061d6dc0d71cc20765f458dec8680e\", \"app_shell_unittests\": \"7217c89bb9c76abb7b5c18f3f017926abbc6f5ca\", \"aura_unittests\": \"90490c7294cb3c3f5e0f39021a46a207b5f41242\", \"base_unittests\": \"8e070399848badf438d191156db2759f81799673\", \"base_util_unittests\": \"36d42a833dcccae259ac6022070905425b0ee87f\", \"blink_common_unittests\": \"11d3df790354ba993c094fa33c2393f21b16f01e\", \"blink_fuzzer_unittests\": \"ea468ee0c2a997603aefc9aebb1b9fafe6662d79\", \"blink_heap_unittests\": \"8bb51a546a447a95a83186d1237a3d41f01d3b0f\", \"blink_platform_unittests\": \"8b8c87ce08412f204459538a734942cd110d59e2\", \"blink_python_tests\": \"694a8acb53a81bb106802e0019c64d19cc1952ef\", \"blink_unittests\": \"47222a12a9695740cfa1d1efe637538a8938e3d4\", \"blink_web_tests\": \"1ccf54bc2fde7d5b0b97284dcdece0a0f73dfbcf\", \"boringssl_crypto_tests\": \"b49158327dea0c794f68265fb3e93ec037c72fce\", \"boringssl_ssl_tests\": \"9702c6687a01e7cb3c2846db134395f3f212075c\", \"browser_tests\": \"7948b08556e2a157fa5d0026f1d14843147d621b\", \"capture_unittests\": \"853806807351278cfb03dabc2bd5d78477ecd148\", \"cast_unittests\": \"ff61889ce5fac417b0b3cf7af8977be3010a9a2a\", \"cc_unittests\": \"6ce03c8e5ccd9a13697224b60386246c10a15ad1\", \"chrome_app_unittests\": \"72d612f5775352704ba33c99be93e3ed4321aa7f\", \"chromedriver_unittests\": \"3773b2ae96097d1c5c7c24d7603c49301ad60154\", \"components_browsertests\": \"ad329ee013d6c9db08e4d759ad549a9c8100e6df\", \"components_unittests\": \"2352f1245c7ce08b17b1bb6ba381f49cd91a29a4\", \"compositor_unittests\": \"b9e2ca6de888115e1c4ce089f619d8fb57c07205\", \"content_browsertests\": \"f882446a300d442394c2565f72b1f7a17c6387ed\", \"content_shell_crash_test\": \"e5c5221d9c790d5f0c7cdec13d3078338aff52a6\", \"content_unittests\": \"29eda20fa374a25412eb736dd0805db5bc74c8f5\", \"crashpad_tests\": \"3a90a935d4d8c394a2cc481fd4bdd6e83ebf2049\", \"cronet_tests\": \"aaa92e264b20e0dbfd18b7a3aea265582d356583\", \"cronet_unittests\": \"3b175a447ec4174b1eae569c0a6a3f5854884c37\", \"crypto_unittests\": \"0d9d082802240d213395b397e717b41fdeb4e47b\", \"dbus_unittests\": \"acb2898c2cb1be63b0433dae4668270890675c70\", \"device_unittests\": \"5fca14bcecc9dcf0dd71d976003ace9088df083f\", \"display_unittests\": \"2037a7d7f7aaf85f788886aa723c7540ecb0560d\", \"events_unittests\": \"d15f50e2a623eafeb7bb725675246993810b7733\", \"extensions_browsertests\": \"a1335dbb1d49b43edfdc9036e083c35a9631ccba\", \"extensions_unittests\": \"8305c8112f7a5fdf9fabe2fd6a02170092984de1\", \"filesystem_service_unittests\": \"0bcaa31776d96b8a538512ab3f17e4d78beafe57\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"36761461dc8ad20202c2ed6e39edc292c332fc36\", \"gfx_unittests\": \"49e4abdf5f170ba598ec83eb1e95c59c91c8e2e5\", \"gin_unittests\": \"f19dbc9e2891b00347bb2437b0dc72684c64f608\", \"google_apis_unittests\": \"6baed2c936a1842fc09a65fca066f65126de474a\", \"gpu_unittests\": \"a6b3344089df6d756ab29147439d084e446aa030\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"012c3e833e5d36df13de28b422c9c2f1a2b81adb\", \"headless_browsertests\": \"ed8c6da291baeffabe0e2b3205881bc057cfa795\", \"headless_unittests\": \"072c25d4c38c82ce8ec84243ec8da5a2da73c0d8\", \"interactive_ui_tests\": \"ec5ed85f62e4debea09b4f1500830c9796b98797\", \"ipc_tests\": \"b3fbfbfdd9d9d9aaae3491edd508331c472f09ff\", \"jingle_unittests\": \"b958a4dfb7f902304fb65ffd8010ccc90d23ac1d\", \"latency_unittests\": \"204721e13bbbe9f8ded1f909ceb3fd4e5ad56c1b\", \"libjingle_xmpp_unittests\": \"19fecf567d4880235bf85fcc2cef800ad09147f0\", \"liburlpattern_unittests\": \"0ff075128c5193f9974e55f1fafa202d39e218c3\", \"media_blink_unittests\": \"36248ad57aa9fefc89dc077ee4f9f101e3c9597c\", \"media_unittests\": \"c85300d776a60f55f72cf5dc290ceb05e1b27056\", \"message_center_unittests\": \"ba97c4728606d2700d2001e3d296fb1f090384bc\", \"metrics_python_tests\": \"90f3947199ce0363a006b813d614bc642b562097\", \"midi_unittests\": \"01d03b2b3bb06ac39ae553021425712b85206724\", \"mojo_core_unittests\": \"ca827e3abc8b3579a7b758572ebe9fb2a782b643\", \"mojo_unittests\": \"cf1eeb20aa910a573ee3fc8eb6127c55da39c801\", \"nacl_helper_nonsfi_unittests\": \"bd5c804c804cc2dfb3869f36e7d17ad0828c4ef0\", \"nacl_loader_unittests\": \"f5264faa1d78ecb74d7baa8c4c0ddfd7cae34dfd\", \"native_theme_unittests\": \"90b7ecc6929218a254a4dcff107a07f3bfd055c4\", \"net_unittests\": \"eff6dd08f9b2bcc66ed1a6797d9c6ac2cbfbbdee\", \"openscreen_unittests\": \"68d93de773119215d04914d0c5c11dac5e18144f\", \"pdf_unittests\": \"e8d65cd54f57b8699f540ff5fbba2466d41d748e\", \"perfetto_unittests\": \"ea3ec419412157816472097dc767cc1ab1f79320\", \"ppapi_unittests\": \"3f5d3387d30ca5305b25c6013d76cea600c966af\", \"printing_unittests\": \"e023fad1193d4eae9b0e197ddc6193428026969c\", \"remoting_unittests\": \"da6c4c43d94fcc42e5a7fccdacb9f2ac039d7b45\", \"sandbox_linux_unittests\": \"dfa56100444c39451f9f142e248f262aa3f767e7\", \"service_manager_unittests\": \"0987b44f6e4ec148911310d05a8f7a6a82878f0c\", \"services_unittests\": \"db504d6df934f1d0ca01df6ac644f60cfd80621a\", \"shell_dialogs_unittests\": \"5601f23299142d9734fd98c762a4f8872fc386f3\", \"skia_unittests\": \"15e02f43b7b3f4aaf4de088339080cfd02ab571f\", \"snapshot_unittests\": \"34f3b89e3186dd30b8cb81a03b37fdbb2d3563dc\", \"sql_unittests\": \"fdeb063f60921b9ffecdf4636be5e3b9a655dc00\", \"storage_unittests\": \"6ecfcb47a061b1c79a7bd37dbd6e570504ce1fe6\", \"sync_integration_tests\": \"24457a6b33ac88b43bfa2b3902d998cf5f4cdb99\", \"telemetry_gpu_unittests\": \"152eaff96b9d4085faf2073f9e4c8e656a6a04d7\", \"telemetry_perf_unittests\": \"3a74e028a7b6d58d0425a5a5cc7df3317abb62d8\", \"telemetry_unittests\": \"86e1810cd5363ec3e5130fc6c14bb8d9bba9d251\", \"traffic_annotation_auditor_unittests\": \"b6593b1ce07ce83141370c0bc2a3dffba3d7ef1d\", \"ui_base_unittests\": \"b02d3371a6ada328f87da1515cf778f8255ce106\", \"ui_touch_selection_unittests\": \"2c6b2a53265f841ab8f5b4b20b8ab720015bd300\", \"unit_tests\": \"62d3d5b39ea1679632550eb759f91792665f3d44\", \"url_unittests\": \"d7e8a89d4b3000967a90a0328e962bc0db72d590\", \"views_perftests\": \"cbefe502c55d895b44e93a5e37285c8044a48ca8\", \"views_unittests\": \"0feadbed59fca683b3e2fc6d7a06b11834727c55\", \"viz_unittests\": \"94fbc5c1c33f0bfade201909296af040fdd8662a\", \"vr_common_unittests\": \"31abe7565b8088bfb94e7dc2373ed39085dc4bbf\", \"vr_pixeltests\": \"9d0976f7b71fd9f4483e132bfa5f70fdf5381831\", \"webdriver_wpt_tests\": \"21adacaff9b5d3e538318cb81fd7f85923fefd46\", \"weblayer_browsertests\": \"9e9ad660aa8ccc882affb552cce7c848ff6f9519\", \"weblayer_unittests\": \"3e9eaa140d812a91e5844422c1bc72da31fef601\", \"wm_unittests\": \"27d44bc9d2a4521e95c40dc1e016ba9bd9a1399d\", \"wtf_unittests\": \"9a4cde4745a04c893f6021c227cfa74ec5553b6a\", \"x11_unittests\": \"0b07aa88f038dd353110a1808c8068cd25e3804d\", \"xr_browser_tests\": \"07fda31f57fb4ca96285ccf01a0da26fdf949320\", \"zlib_unittests\": \"e0dfd60e2292324e3f4a2b08b03604fdbb626a24\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-72-9inl\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611676468613603",
"status": "COMPLETED",
"status_changed_ts": "1611679359889779",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179999",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bedf32bc66cf6f9add51eaccf400de80d08eb4ac",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022458516213137840",
"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/8857028454173888576/+/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:515838c6a73a7010",
"user_agent:luci-scheduler"
],
"updated_ts": "1611679359899773",
"url": "https://ci.chromium.org/b/8857028454173888576",
"utcnow_ts": "1611679360994537"
}
}
[16:42:41.018] Invocation finished in 48m16.564590182s with status SUCCEEDED