[18:31:18.152] New invocation is queued and will start shortly
[18:31:19.331] Starting the invocation (attempt 1)
[18:31:19.393] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:31:19.398] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:31:19.399] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022267451318125632",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022267451318125632",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"gitiles_ref:refs/heads/master"
]
}
[18:31:20.408] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611858679506684",
"id": "8856837389236275296",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611858680101893",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180070",
"builder:Linux Builder (dbg)",
"buildset:commit/git/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022267451318125632",
"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/8856837389236275296/+/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": "1611858680102261",
"url": "https://ci.chromium.org/b/8856837389236275296",
"utcnow_ts": "1611858680385128"
}
}
[18:31:20.408] Task URL: https://ci.chromium.org/b/8856837389236275296
[18:31:20.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:2:0) after 1m0s
[18:31:25.111] Received PubSub notification, asking Buildbucket for the build status
[18:31:25.560] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:20.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:2:0)
[18:32:20.425] Timer tick, asking Buildbucket for the build status
[18:32:20.619] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:20.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:4:0) after 1m0s
[18:33:20.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:4:0)
[18:33:20.624] Timer tick, asking Buildbucket for the build status
[18:33:20.757] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:20.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:5:0) after 1m0s
[18:34:20.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:5:0)
[18:34:20.792] Timer tick, asking Buildbucket for the build status
[18:34:21.158] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:21.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:6:0) after 1m0s
[18:35:21.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:6:0)
[18:35:21.199] Timer tick, asking Buildbucket for the build status
[18:35:22.280] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:22.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:7:0) after 1m0s
[18:36:22.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:7:0)
[18:36:22.317] Timer tick, asking Buildbucket for the build status
[18:36:22.503] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:22.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:8:0) after 1m0s
[18:37:22.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:8:0)
[18:37:22.634] Timer tick, asking Buildbucket for the build status
[18:37:23.089] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:23.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:9:0) after 1m0s
[18:38:23.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:9:0)
[18:38:23.294] Timer tick, asking Buildbucket for the build status
[18:38:23.417] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:23.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:10:0) after 1m0s
[18:39:23.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:10:0)
[18:39:23.523] Timer tick, asking Buildbucket for the build status
[18:39:23.830] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:23.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:11:0) after 1m0s
[18:40:23.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:11:0)
[18:40:23.935] Timer tick, asking Buildbucket for the build status
[18:40:24.163] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:24.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:12:0) after 1m0s
[18:41:24.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:12:0)
[18:41:24.141] Timer tick, asking Buildbucket for the build status
[18:41:24.784] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:24.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:13:0) after 1m0s
[18:42:24.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:13:0)
[18:42:24.809] Timer tick, asking Buildbucket for the build status
[18:42:24.888] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:14:0) after 1m0s
[18:43:24.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:14:0)
[18:43:24.910] Timer tick, asking Buildbucket for the build status
[18:43:24.988] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:24.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:15:0) after 1m0s
[18:44:25.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:15:0)
[18:44:25.008] Timer tick, asking Buildbucket for the build status
[18:44:25.123] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:25.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:16:0) after 1m0s
[18:45:27.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:16:0)
[18:45:27.284] Timer tick, asking Buildbucket for the build status
[18:45:27.382] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:27.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:17:0) after 1m0s
[18:46:27.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:17:0)
[18:46:27.553] Timer tick, asking Buildbucket for the build status
[18:46:27.684] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:27.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:18:0) after 1m0s
[18:47:28.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:18:0)
[18:47:28.322] Timer tick, asking Buildbucket for the build status
[18:47:28.572] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:28.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:19:0) after 1m0s
[18:48:28.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:19:0)
[18:48:28.862] Timer tick, asking Buildbucket for the build status
[18:48:29.080] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:29.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:20:0) after 1m0s
[18:49:29.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:20:0)
[18:49:29.936] Timer tick, asking Buildbucket for the build status
[18:49:30.131] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:30.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:21:0) after 1m0s
[18:50:30.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:21:0)
[18:50:30.162] Timer tick, asking Buildbucket for the build status
[18:50:30.296] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:30.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:22:0) after 1m0s
[18:51:30.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:22:0)
[18:51:30.492] Timer tick, asking Buildbucket for the build status
[18:51:31.413] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:23:0) after 1m0s
[18:52:31.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:23:0)
[18:52:31.462] Timer tick, asking Buildbucket for the build status
[18:52:31.540] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:31.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:24:0) after 1m0s
[18:53:31.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:24:0)
[18:53:31.586] Timer tick, asking Buildbucket for the build status
[18:53:31.699] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:31.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:25:0) after 1m0s
[18:54:31.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:25:0)
[18:54:31.724] Timer tick, asking Buildbucket for the build status
[18:54:31.796] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:31.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:26:0) after 1m0s
[18:55:31.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:26:0)
[18:55:31.828] Timer tick, asking Buildbucket for the build status
[18:55:31.884] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:31.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:27:0) after 1m0s
[18:56:31.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:27:0)
[18:56:31.934] Timer tick, asking Buildbucket for the build status
[18:56:32.074] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:32.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:28:0) after 1m0s
[18:57:32.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:28:0)
[18:57:32.128] Timer tick, asking Buildbucket for the build status
[18:57:32.327] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:32.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:29:0) after 1m0s
[18:58:32.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:29:0)
[18:58:32.372] Timer tick, asking Buildbucket for the build status
[18:58:32.563] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:32.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:30:0) after 1m0s
[18:59:32.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:30:0)
[18:59:32.693] Timer tick, asking Buildbucket for the build status
[18:59:32.847] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:32.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:31:0) after 1m0s
[19:00:33.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:31:0)
[19:00:33.052] Timer tick, asking Buildbucket for the build status
[19:00:33.166] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:33.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:32:0) after 1m0s
[19:01:33.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:32:0)
[19:01:33.277] Timer tick, asking Buildbucket for the build status
[19:01:33.456] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:33.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:33:0) after 1m0s
[19:02:33.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:33:0)
[19:02:33.525] Timer tick, asking Buildbucket for the build status
[19:02:33.873] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:33.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:34:0) after 1m0s
[19:03:33.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:34:0)
[19:03:33.918] Timer tick, asking Buildbucket for the build status
[19:03:34.092] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:34.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:35:0) after 1m0s
[19:04:34.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:35:0)
[19:04:34.163] Timer tick, asking Buildbucket for the build status
[19:04:34.298] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:34.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:36:0) after 1m0s
[19:05:34.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:36:0)
[19:05:34.326] Timer tick, asking Buildbucket for the build status
[19:05:34.409] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:34.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:37:0) after 1m0s
[19:06:34.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:37:0)
[19:06:34.431] Timer tick, asking Buildbucket for the build status
[19:06:35.367] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:35.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:38:0) after 1m0s
[19:07:35.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:38:0)
[19:07:35.384] Timer tick, asking Buildbucket for the build status
[19:07:35.513] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:35.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:39:0) after 1m0s
[19:08:35.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:39:0)
[19:08:35.625] Timer tick, asking Buildbucket for the build status
[19:08:35.727] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:35.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:40:0) after 1m0s
[19:09:35.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:40:0)
[19:09:35.799] Timer tick, asking Buildbucket for the build status
[19:09:35.984] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:35.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:41:0) after 1m0s
[19:10:36.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:41:0)
[19:10:36.278] Timer tick, asking Buildbucket for the build status
[19:10:36.712] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:36.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:42:0) after 1m0s
[19:11:36.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:42:0)
[19:11:36.974] Timer tick, asking Buildbucket for the build status
[19:11:37.192] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:37.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:43:0) after 1m0s
[19:12:37.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:43:0)
[19:12:37.570] Timer tick, asking Buildbucket for the build status
[19:12:37.633] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:37.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:44:0) after 1m0s
[19:13:37.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:44:0)
[19:13:37.786] Timer tick, asking Buildbucket for the build status
[19:13:38.003] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:38.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:45:0) after 1m0s
[19:14:38.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:45:0)
[19:14:38.318] Timer tick, asking Buildbucket for the build status
[19:14:38.568] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:38.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:46:0) after 1m0s
[19:15:38.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:46:0)
[19:15:38.664] Timer tick, asking Buildbucket for the build status
[19:15:38.785] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:38.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:47:0) after 1m0s
[19:16:38.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:47:0)
[19:16:38.958] Timer tick, asking Buildbucket for the build status
[19:16:39.148] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:39.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:48:0) after 1m0s
[19:17:39.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:48:0)
[19:17:39.240] Timer tick, asking Buildbucket for the build status
[19:17:39.465] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:39.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:49:0) after 1m0s
[19:18:39.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:49:0)
[19:18:39.528] Timer tick, asking Buildbucket for the build status
[19:18:39.647] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:39.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:50:0) after 1m0s
[19:19:39.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:50:0)
[19:19:39.641] Timer tick, asking Buildbucket for the build status
[19:19:39.742] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:39.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:51:0) after 1m0s
[19:20:39.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:51:0)
[19:20:39.803] Timer tick, asking Buildbucket for the build status
[19:20:39.923] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:39.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:52:0) after 1m0s
[19:21:40.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:52:0)
[19:21:40.002] Timer tick, asking Buildbucket for the build status
[19:21:40.171] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:40.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:53:0) after 1m0s
[19:22:40.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:53:0)
[19:22:40.571] Timer tick, asking Buildbucket for the build status
[19:22:40.742] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:40.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:54:0) after 1m0s
[19:23:40.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:54:0)
[19:23:40.869] Timer tick, asking Buildbucket for the build status
[19:23:41.540] Build 8856837389236275296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:41.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022267451318125632:55:0) after 1m0s
[19:24:30.980] Received PubSub notification, asking Buildbucket for the build status
[19:24:31.150] Build 8856837389236275296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:24:31.150] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611861870525884",
"created_by": "project:chromium",
"created_ts": "1611858679506684",
"id": "8856837389236275296",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\"}}",
"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\": \"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\", \"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\": 180070, \"got_angle_revision\": \"a408ce8349289c8fe457a5ebccb8c4cbac7b9c3f\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\", \"got_revision_cp\": \"refs/heads/master@{#848180}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"609f77888b667dbb70edc38715437b69f15a4dc4\", \"got_v8_revision_cp\": \"refs/heads/9.0.99@{#1}\", \"got_webrtc_revision\": \"b70c9531ee0c00d5d8aa104a3e5b76e6bc1412b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33084}\", \"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\", \"prev_got_revision\": \"0cb5c1a2e55d74bc256136dbbba37d6c0da01b39\", \"prev_got_revision_cp\": \"refs/heads/master@{#848163}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e4a469e718a0b715ee27fce2d176f68a69a3cc1\", \"swarm_hashes_refs/heads/master(at){#848180}_without_patch\": {\"absl_hardening_tests\": \"33151b515c505123c70b4cf15092c88d150da9b1\", \"accessibility_unittests\": \"f8800f0aa3cc4f5df081d321f72ca837a6345a32\", \"angle_unittests\": \"9448a96791a201f0076f893a84681c16de8b7177\", \"app_shell_unittests\": \"0f37c5564c942dca225dbd63916439d2652eb941\", \"aura_unittests\": \"1dcade9d9596f5bdc91275e72ecb5fe25383028f\", \"base_unittests\": \"8236470da8b9c6d1eb7bce2b2c98a97e405c67f4\", \"base_util_unittests\": \"04c22db0347d0e373476ff46af55ac38db969933\", \"blink_common_unittests\": \"db93ee0de6da2c2ecebb971fa4c4a4c89083644f\", \"blink_fuzzer_unittests\": \"fcbf33b9797bee28e243a6f1b22802985332296f\", \"blink_heap_unittests\": \"c00d4f70eb0ba6d71373a39b4e1d5f2e40c4ad9e\", \"blink_platform_unittests\": \"691926ab8a679979e4becd23201ba4db4ff1bf19\", \"blink_python_tests\": \"aac9fbbc5d837b6d311bb85b19d9ebe29ed73064\", \"blink_unittests\": \"a0387ffa62e019234cbcae84a2aed51521d2793a\", \"blink_web_tests\": \"e88bcc0310e7a385c6d84134345c472aab1f73fb\", \"boringssl_crypto_tests\": \"6ff2704837bfe06fa4207a164d117a8af105a8e9\", \"boringssl_ssl_tests\": \"e8432a6209644bee823e925a25e8554e31ac4f9b\", \"browser_tests\": \"ce0236bdd93ed6b75d7ca0dd700e0a76240a1981\", \"capture_unittests\": \"c8880cb4dc7b973111bae48952a1bbefdb28cf60\", \"cast_unittests\": \"67ee2f365a5dcf4c6078202267efda62eef17c5e\", \"cc_unittests\": \"3e3ebba43e6638b1033b0477c7de6f854a62f931\", \"chrome_app_unittests\": \"14cf5fb13201f3fc04e40c5700a1c7b81922a765\", \"chromedriver_unittests\": \"e7c7f8e9a7d0355df384b6169a3e3a313b56ee77\", \"components_browsertests\": \"2951317506ab92f251caaf8bcb73832d9d3c8d64\", \"components_unittests\": \"509723e9f555bf8eeebd9d8bdf988298d6c442c0\", \"compositor_unittests\": \"3a866aaaf6b65fbd42637247603e15dd073775ef\", \"content_browsertests\": \"a614c987e2143c6d515644c9c3bc9333f991f529\", \"content_shell_crash_test\": \"7cd62fd57b591cd9f34fc1a10961f1edc8a69e00\", \"content_unittests\": \"3e709c9edcffa6aa5ae9ffaaa79983c9cf7300ef\", \"crashpad_tests\": \"afc533650c666aa7ef9eadbc0218df5565cf7876\", \"cronet_tests\": \"bb81b9b85624957a07c668dbe091a370ce072957\", \"cronet_unittests\": \"ec226642691f3fe9c57392ae990b16af74ac16ea\", \"crypto_unittests\": \"eef6a6f907819fab3d446c5d0580d60375bc86a2\", \"dbus_unittests\": \"de03504f5f30d69e1c1fb97cf33362c25baac3cb\", \"device_unittests\": \"74e71fb33b5abec7daa6a6547685bf206ae46910\", \"display_unittests\": \"af9773bec10d26a39a861852143419539a699550\", \"events_unittests\": \"5528a807ab432f788efa06f53578fe9d7a84a5d0\", \"extensions_browsertests\": \"0ac1687690c17dc12bcd4c4e7598fbd5226f3372\", \"extensions_unittests\": \"bafe53782e088bd0640553c5094512df0f6d97c4\", \"filesystem_service_unittests\": \"e05cd4aa6ec49947f6d71d2fd3118630cb8a05d0\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"0a0bc17eed3270cbe02adc4316a6027d3671c976\", \"gfx_unittests\": \"8617c72ef773a75deabf197d30afd325078b36bf\", \"gin_unittests\": \"acfa5f6bce1e63970130a9e694820bcbd09a0831\", \"google_apis_unittests\": \"d6b29d15b5dbd0abde6fcdc423212f9622c1d782\", \"gpu_unittests\": \"5958d5043ed9e041baff4d64692c72f2d8e612d2\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"5b50c7f3cc72b641eef2b2dde7fdfe9c461ddcd3\", \"headless_browsertests\": \"6ec5a7374aab06b41d75d01895ae7745e2fb6a10\", \"headless_unittests\": \"389f53ab4d13cfad67ed9dd996c790b6f28d9156\", \"interactive_ui_tests\": \"919cffcb39028e77cc3a155a0d9d702eda1e0e6f\", \"ipc_tests\": \"5226bda3b9d1de3db9e14786befbb74241e3a10a\", \"jingle_unittests\": \"b690774cd5b483d9c3c0affb09dbb69ae6cf6789\", \"latency_unittests\": \"52455f4de66d6280631d0cb6fa3e0209c35edfb1\", \"libjingle_xmpp_unittests\": \"4a32fc6dacd683843cb760d4c88d472ef91538a9\", \"liburlpattern_unittests\": \"79e2b17009ff1a3e8bb615a52832b7998de82a91\", \"media_blink_unittests\": \"d991c404c1142522f154e18fe5510bbe41d5d2c6\", \"media_unittests\": \"774b73b77624eaf5f1626666ec41b25407216e34\", \"message_center_unittests\": \"b760a85d0cfb25302527e8f350d90aac2040112d\", \"metrics_python_tests\": \"7a55e503796833c18930286998c739c37da2a7e8\", \"midi_unittests\": \"885ad53617fa7b46c2984af84ef9221569c43b1a\", \"mojo_core_unittests\": \"b3a93700b6bc24033c32eebf9e46142b7be83859\", \"mojo_unittests\": \"b3bcecdeb9e27e493a5f8977e7ca907a368e26ba\", \"nacl_helper_nonsfi_unittests\": \"69e97bd3a09011ece6a55c9712cfd63f0f90dc46\", \"nacl_loader_unittests\": \"7ba818f6aa97794e6612aa006add6a5dd68aa957\", \"native_theme_unittests\": \"174f5d5085426110e69035496247f5bd36875e18\", \"net_unittests\": \"d3714bb9aa4e3709f1942419addc86821e0972f3\", \"openscreen_unittests\": \"d894d67779f08699a22b22dce3c86bb0fa56a11e\", \"pdf_unittests\": \"04fe1f6d64262fc5da5a48731a62cf676ae4bf69\", \"perfetto_unittests\": \"63c05ccf1981671fab6043fb2679773f9e134f06\", \"ppapi_unittests\": \"0997468cd597d9bace1ee0234583a1f44bec633f\", \"printing_unittests\": \"e204bd2989237ed44ea6d4c8e10a68b3eb62599b\", \"remoting_unittests\": \"41c33c4e66c5a34705c8d559ef831167c6e6419e\", \"sandbox_linux_unittests\": \"40b5ec557b1ddd938b68c0384ab2b142f9c6db16\", \"service_manager_unittests\": \"5fa0e7e2cb696d5b4c214e2df67c6e6dd8a75442\", \"services_unittests\": \"2beb6ec24d27dc125d830ef4b9f8ca4efe5aa2a2\", \"shell_dialogs_unittests\": \"b315e7ccf5626f8a930b0dd88e14de28cc87cb51\", \"skia_unittests\": \"f41e1a2597650505a9ecf22093d243511924214c\", \"snapshot_unittests\": \"7efcdc66f4a445e3f987190d27e89f2f6d084514\", \"sql_unittests\": \"2ca36e25ecfe887437416ca62ceb8e46d119762a\", \"storage_unittests\": \"f63d3cd341a6fb1d664ffba8f68b1c9a65b430da\", \"sync_integration_tests\": \"d3e730d5dda12f798fd10a7dd32f6fdc7ff41c38\", \"telemetry_gpu_unittests\": \"56e8e35a274240a6f9ea5f8703b297f80b55a223\", \"telemetry_perf_unittests\": \"6cc393c6673f0ff1542c2a70f522b5a6422a5438\", \"telemetry_unittests\": \"9e9c49f81f3ee8a2ae43573f60c1f5e3b5656e5d\", \"traffic_annotation_auditor_unittests\": \"776b1b7c90f0f4fbff2179e55165f2d730d7c40a\", \"ui_base_unittests\": \"380df4d6ad2b13a1204073c729aabbfaa0f47730\", \"ui_touch_selection_unittests\": \"d57bcea101ec3f8fce83f2da1a9d9bfac1383f3d\", \"unit_tests\": \"738b2d4eb442be1c47744f6270081cadd1e66d47\", \"url_unittests\": \"114a21bd6344d84e36a4aefc1e8ac21d30f26771\", \"views_perftests\": \"263d484b8fc08eb5677d4bcebda8ec1ea195a774\", \"views_unittests\": \"e7cdb8d205e83e603819614dfcc2153ee4c862bf\", \"viz_unittests\": \"fd741392a7d7c11f9149a9627309517306fc5316\", \"vr_common_unittests\": \"065eff7ee9b6962b90fec1a6a05f99e607ec7d28\", \"vr_pixeltests\": \"3efaa507fbd3b61ee86989fd7eb2534747770435\", \"webdriver_wpt_tests\": \"24f77871dcf4b852ed9cc46dc3081cd1dcee1be9\", \"weblayer_browsertests\": \"cbbd91915ab869747ead80e503ffc061c89445a5\", \"weblayer_unittests\": \"7c288bba7ac67abdf66b1bf9669a0e4e021721a8\", \"wm_unittests\": \"e5e11775b923cda6fc1910714c6eec9c8b3895ce\", \"wtf_unittests\": \"372772809fa32ecde9c804a0da1d8cc9e274a076\", \"x11_unittests\": \"dcbd4e32ca51d48ab123c8cbd8836b184eeb4b2f\", \"xr_browser_tests\": \"b4f85962a334db97924769cbb33bacf8f178ea6e\", \"zlib_unittests\": \"defaf58ecd9d169d6d9423318a1e22139999941d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1565bd2e801a59db86c3cb29ff80b2e229b1f19a08963dbe4c2b49186438622b_v2\", \"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_746f25208a125120dfc7ef61e5ef35531bce9c0f7be870eb0811bf6f56bb01d6_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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611858682494065",
"status": "COMPLETED",
"status_changed_ts": "1611861870767087",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180070",
"builder:Linux Builder (dbg)",
"buildset:commit/git/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e4a469e718a0b715ee27fce2d176f68a69a3cc1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022267451318125632",
"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/8856837389236275296/+/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:516315236bafb510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611861870771891",
"url": "https://ci.chromium.org/b/8856837389236275296",
"utcnow_ts": "1611861871132675"
}
}
[19:24:31.150] Invocation finished in 53m13.012488279s with status SUCCEEDED