[18:01:28.431] New invocation is queued and will start shortly
[18:01:29.543] Starting the invocation (attempt 1)
[18:01:29.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:01:29.582] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:01:29.582] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026617982365782240",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6194f01f99c4b639e739ef3578a53e2a5d06d55e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9026617982365782240",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"gitiles_ref:refs/heads/master"
]
}
[18:01:31.059] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607709689709854",
"id": "8861187920361438064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6194f01f99c4b639e739ef3578a53e2a5d06d55e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607709690825247",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178574",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026617982365782240",
"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/8861187920361438064/+/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": "1607709690825467",
"url": "https://ci.chromium.org/b/8861187920361438064",
"utcnow_ts": "1607709691045796"
}
}
[18:01:31.059] Task URL: https://ci.chromium.org/b/8861187920361438064
[18:01:31.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:2:0) after 1m0s
[18:02:31.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:2:0)
[18:02:31.052] Timer tick, asking Buildbucket for the build status
[18:02:31.340] Build 8861187920361438064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:31.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:3:0) after 1m0s
[18:02:50.176] Received PubSub notification, asking Buildbucket for the build status
[18:02:50.350] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:31.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:3:0)
[18:03:31.371] Timer tick, asking Buildbucket for the build status
[18:03:31.473] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:31.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:5:0) after 1m0s
[18:04:31.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:5:0)
[18:04:31.473] Timer tick, asking Buildbucket for the build status
[18:04:31.612] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:31.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:6:0) after 1m0s
[18:05:31.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:6:0)
[18:05:31.596] Timer tick, asking Buildbucket for the build status
[18:05:31.697] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:31.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:7:0) after 1m0s
[18:06:31.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:7:0)
[18:06:31.723] Timer tick, asking Buildbucket for the build status
[18:06:31.834] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:31.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:8:0) after 1m0s
[18:07:31.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:8:0)
[18:07:31.856] Timer tick, asking Buildbucket for the build status
[18:07:31.981] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:31.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:9:0) after 1m0s
[18:08:32.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:9:0)
[18:08:32.097] Timer tick, asking Buildbucket for the build status
[18:08:32.230] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:32.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:10:0) after 1m0s
[18:09:32.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:10:0)
[18:09:32.275] Timer tick, asking Buildbucket for the build status
[18:09:32.361] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:11:0) after 1m0s
[18:10:32.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:11:0)
[18:10:32.391] Timer tick, asking Buildbucket for the build status
[18:10:36.635] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:36.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:12:0) after 1m0s
[18:11:36.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:12:0)
[18:11:36.676] Timer tick, asking Buildbucket for the build status
[18:11:37.122] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:37.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:13:0) after 1m0s
[18:12:37.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:13:0)
[18:12:37.153] Timer tick, asking Buildbucket for the build status
[18:12:37.210] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:37.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:14:0) after 1m0s
[18:13:37.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:14:0)
[18:13:37.204] Timer tick, asking Buildbucket for the build status
[18:13:37.295] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:37.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:15:0) after 1m0s
[18:14:37.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:15:0)
[18:14:37.363] Timer tick, asking Buildbucket for the build status
[18:14:37.419] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:37.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:16:0) after 1m0s
[18:15:37.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:16:0)
[18:15:37.501] Timer tick, asking Buildbucket for the build status
[18:15:37.585] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:37.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:17:0) after 1m0s
[18:16:37.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:17:0)
[18:16:37.664] Timer tick, asking Buildbucket for the build status
[18:16:37.833] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:37.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:18:0) after 1m0s
[18:17:37.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:18:0)
[18:17:37.924] Timer tick, asking Buildbucket for the build status
[18:17:37.985] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:37.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:19:0) after 1m0s
[18:18:38.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:19:0)
[18:18:38.076] Timer tick, asking Buildbucket for the build status
[18:18:38.193] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:38.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:20:0) after 1m0s
[18:19:38.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:20:0)
[18:19:38.226] Timer tick, asking Buildbucket for the build status
[18:19:38.285] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:38.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:21:0) after 1m0s
[18:20:38.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:21:0)
[18:20:38.362] Timer tick, asking Buildbucket for the build status
[18:20:38.416] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:38.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:22:0) after 1m0s
[18:21:38.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:22:0)
[18:21:38.414] Timer tick, asking Buildbucket for the build status
[18:21:38.779] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:38.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:23:0) after 1m0s
[18:22:38.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:23:0)
[18:22:38.809] Timer tick, asking Buildbucket for the build status
[18:22:38.900] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:24:0) after 1m0s
[18:23:38.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:24:0)
[18:23:38.917] Timer tick, asking Buildbucket for the build status
[18:23:38.991] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:38.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:25:0) after 1m0s
[18:24:40.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:25:0)
[18:24:40.158] Timer tick, asking Buildbucket for the build status
[18:24:40.229] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:40.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:26:0) after 1m0s
[18:25:40.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:26:0)
[18:25:40.686] Timer tick, asking Buildbucket for the build status
[18:25:40.777] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:40.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:27:0) after 1m0s
[18:26:40.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:27:0)
[18:26:40.889] Timer tick, asking Buildbucket for the build status
[18:26:41.210] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:41.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:28:0) after 1m0s
[18:27:41.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:28:0)
[18:27:41.602] Timer tick, asking Buildbucket for the build status
[18:27:41.817] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:41.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:29:0) after 1m0s
[18:28:42.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:29:0)
[18:28:42.026] Timer tick, asking Buildbucket for the build status
[18:28:48.755] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:48.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:30:0) after 1m0s
[18:29:48.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:30:0)
[18:29:48.777] Timer tick, asking Buildbucket for the build status
[18:29:48.854] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:48.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:31:0) after 1m0s
[18:30:48.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:31:0)
[18:30:48.938] Timer tick, asking Buildbucket for the build status
[18:30:49.029] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:49.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:32:0) after 1m0s
[18:31:49.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:32:0)
[18:31:49.054] Timer tick, asking Buildbucket for the build status
[18:31:49.169] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:49.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:33:0) after 1m0s
[18:32:49.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:33:0)
[18:32:49.199] Timer tick, asking Buildbucket for the build status
[18:32:49.253] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:49.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:34:0) after 1m0s
[18:33:49.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:34:0)
[18:33:49.355] Timer tick, asking Buildbucket for the build status
[18:33:49.445] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:49.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:35:0) after 1m0s
[18:34:49.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:35:0)
[18:34:49.516] Timer tick, asking Buildbucket for the build status
[18:34:49.585] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:49.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:36:0) after 1m0s
[18:35:49.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:36:0)
[18:35:49.620] Timer tick, asking Buildbucket for the build status
[18:35:49.699] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:49.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:37:0) after 1m0s
[18:36:49.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:37:0)
[18:36:49.712] Timer tick, asking Buildbucket for the build status
[18:36:49.956] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:38:0) after 1m0s
[18:37:49.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:38:0)
[18:37:49.976] Timer tick, asking Buildbucket for the build status
[18:37:50.075] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:39:0) after 1m0s
[18:38:50.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:39:0)
[18:38:50.150] Timer tick, asking Buildbucket for the build status
[18:38:50.415] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:50.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:40:0) after 1m0s
[18:39:50.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:40:0)
[18:39:50.479] Timer tick, asking Buildbucket for the build status
[18:39:50.548] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:50.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:41:0) after 1m0s
[18:40:50.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:41:0)
[18:40:50.612] Timer tick, asking Buildbucket for the build status
[18:40:50.672] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:50.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:42:0) after 1m0s
[18:41:50.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:42:0)
[18:41:50.697] Timer tick, asking Buildbucket for the build status
[18:41:51.007] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:51.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:43:0) after 1m0s
[18:42:51.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:43:0)
[18:42:51.064] Timer tick, asking Buildbucket for the build status
[18:42:51.157] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:51.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:44:0) after 1m0s
[18:43:51.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:44:0)
[18:43:51.255] Timer tick, asking Buildbucket for the build status
[18:43:51.322] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:51.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:45:0) after 1m0s
[18:44:51.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:45:0)
[18:44:51.418] Timer tick, asking Buildbucket for the build status
[18:44:51.498] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:51.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:46:0) after 1m0s
[18:45:51.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:46:0)
[18:45:51.526] Timer tick, asking Buildbucket for the build status
[18:45:51.755] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:51.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:47:0) after 1m0s
[18:46:51.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:47:0)
[18:46:51.783] Timer tick, asking Buildbucket for the build status
[18:46:51.908] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:51.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:48:0) after 1m0s
[18:47:51.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:48:0)
[18:47:51.954] Timer tick, asking Buildbucket for the build status
[18:47:52.135] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:52.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:49:0) after 1m0s
[18:48:52.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:49:0)
[18:48:52.268] Timer tick, asking Buildbucket for the build status
[18:48:52.844] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:50:0) after 1m0s
[18:49:52.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:50:0)
[18:49:52.864] Timer tick, asking Buildbucket for the build status
[18:49:53.156] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:53.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:51:0) after 1m0s
[18:50:53.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:51:0)
[18:50:53.215] Timer tick, asking Buildbucket for the build status
[18:50:53.408] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:53.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:52:0) after 1m0s
[18:51:53.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:52:0)
[18:51:53.439] Timer tick, asking Buildbucket for the build status
[18:51:53.564] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:53.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:53:0) after 1m0s
[18:52:53.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:53:0)
[18:52:53.541] Timer tick, asking Buildbucket for the build status
[18:52:53.600] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:53.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:54:0) after 1m0s
[18:53:53.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:54:0)
[18:53:53.615] Timer tick, asking Buildbucket for the build status
[18:53:53.838] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:53.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:55:0) after 1m0s
[18:54:53.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:55:0)
[18:54:53.927] Timer tick, asking Buildbucket for the build status
[18:54:53.991] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:53.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:56:0) after 1m0s
[18:55:54.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:56:0)
[18:55:54.078] Timer tick, asking Buildbucket for the build status
[18:55:54.238] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:54.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:57:0) after 1m0s
[18:56:54.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:57:0)
[18:56:54.270] Timer tick, asking Buildbucket for the build status
[18:56:54.393] Build 8861187920361438064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026617982365782240:58:0) after 1m0s
[18:57:23.368] Received PubSub notification, asking Buildbucket for the build status
[18:57:24.031] Build 8861187920361438064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:57:24.031] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607713042399786",
"created_by": "project:chromium",
"created_ts": "1607709689709854",
"id": "8861187920361438064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6194f01f99c4b639e739ef3578a53e2a5d06d55e\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"6194f01f99c4b639e739ef3578a53e2a5d06d55e\", \"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-east1-d-8-73-ikou\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178574, \"got_angle_revision\": \"a77bc1f1e69056a533af0911d590538ae8900cdd\", \"got_dawn_revision\": \"6bcd4aceef100810284d61bd9dad0e9bd05e4c92\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"6194f01f99c4b639e739ef3578a53e2a5d06d55e\", \"got_revision_cp\": \"refs/heads/master@{#836170}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"0a64a974755521dbb2b16332002a927fb830a0d4\", \"got_v8_revision\": \"4abdaef9a4ed49f097b3fd9514b8f21a25726636\", \"got_v8_revision_cp\": \"refs/heads/8.9.136@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"6194f01f99c4b639e739ef3578a53e2a5d06d55e\", \"swarm_hashes_refs/heads/master(at){#836170}_without_patch\": {\"absl_hardening_tests\": \"442468d0954d305564d925387ea22f825c3d4acf\", \"accessibility_unittests\": \"94113b054247a94af3b8ce26845f451c4232c9d1\", \"angle_unittests\": \"c806e2160513dc09de651711d37eb761298adfe1\", \"app_shell_unittests\": \"02804299684945e804a7a1e68554fdb7b6595598\", \"aura_unittests\": \"71a7f4ebea296fe752fb2cd364fab862ccb0311e\", \"base_unittests\": \"ca97ba03b53b3fa5867c7ae251affeec73766e04\", \"base_util_unittests\": \"6ad2b670002d932cea56f02b7a7ce14d407a1e50\", \"blink_common_unittests\": \"f07f6038e77537e1cc91f8dfb7024a6053c0d187\", \"blink_fuzzer_unittests\": \"13ae58c77ff83f1cbd493606d6e883412588d036\", \"blink_heap_unittests\": \"b4fdab792101d5f95c90d3d3008bd15d6dde1fb3\", \"blink_platform_unittests\": \"9f7a90b338cf93dccdc98ca22a883dd726a4780e\", \"blink_python_tests\": \"67325d9dda87573ae6b561ba9f65894263c45c36\", \"blink_unittests\": \"b3c16e884f12edd570caa5e6b29cb5f5b36715e9\", \"blink_web_tests\": \"e1fc3a89ddcd62959d8de33d6bf4c7b476794747\", \"boringssl_crypto_tests\": \"09c1ee625bf6be9833323f5e15508c5d244b63c6\", \"boringssl_ssl_tests\": \"287a99162650d6d66449e8fca2aeb2f31121cec3\", \"browser_tests\": \"abde6440f2d210d8198eb1f440c31e3e4ba493af\", \"capture_unittests\": \"b64d88cd2348df179c9f167778e0240df822d34c\", \"cast_unittests\": \"a353a756faf3dd6317d79c2cbe4d4cab01fcaab4\", \"cc_unittests\": \"558fd6303f35e3ec32d1e887b8a7e8f59e37d038\", \"chrome_app_unittests\": \"57957c85eb101459d3a04d9cc1496c95d312e09f\", \"chromedriver_unittests\": \"959fba4fdfec50bf4659fc18d0f9be3c2d17fa90\", \"components_browsertests\": \"f7f9be13475f9c00c8b7a405617e4f1499d3ffed\", \"components_unittests\": \"38533e3b266ed516e0d7e5421d833ff831ae0d92\", \"compositor_unittests\": \"f70c64393f88d80dc7ad1c20caffeccce3b53c33\", \"content_browsertests\": \"8937fb39de6080814ac5ec42a072c5a3b00eac9e\", \"content_shell_crash_test\": \"1721933c08a0eb8336ce68e53a5dc0de29f73576\", \"content_unittests\": \"0ad749b9fa981dd8ef81bce9403f018e5a0e02b0\", \"crashpad_tests\": \"218c6456886345d664a6ba8fc660b259dfef511d\", \"cronet_tests\": \"1391cdca4637184698c4fd52d6348161198dda69\", \"cronet_unittests\": \"2e633de727b69e12a55041bf4ace323972e478de\", \"crypto_unittests\": \"fb78908d491d286cd327c2af55c452d196ad4ba9\", \"dbus_unittests\": \"2ba0a5a2dd77853c472ab4d121dab04ea2084663\", \"device_unittests\": \"f6c659684160c4c8a0a08c857b67c3bdff62e919\", \"display_unittests\": \"3d112152caaed24db93052f38d1be6fda95b39a1\", \"events_unittests\": \"13164f707f15c9e95001e488fe29c3bd84331bd3\", \"extension_docserver_python_unittests\": \"43a5fea6d587f83843c2908de552ccd65cd25cb4\", \"extensions_browsertests\": \"54487d94ff808af8bfd34b0e19835da9ccd633c7\", \"extensions_unittests\": \"2fb7f426ab7d1b0b1b75e3f153d9b98d67b49e98\", \"filesystem_service_unittests\": \"48ba1471c9e31d23a08e6b02026c12b04e01bb7d\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"cd797d9ef97b7d261d21ecc8db2c8a62c6ad3f0f\", \"gfx_unittests\": \"af6106652dfcbd0b04bc08eda3cb2b29f718892a\", \"gin_unittests\": \"3e073768a4f173db829fcade27992ba202ff3416\", \"google_apis_unittests\": \"4064ae0f748e716cd767f377137177d933b42b63\", \"gpu_unittests\": \"6e3d76fff38e7fb6aae64d69c04017bc7cd53757\", \"grit_python_unittests\": \"4240fd59c31e9646d2ab4fe1082f5d79a3314641\", \"gwp_asan_unittests\": \"dffaa188851f3158a51e34a4a3c7e10da96b9516\", \"headless_browsertests\": \"d823f623cb92f10ac02ded0c212688cc2f052d0e\", \"headless_unittests\": \"7bb6f750e984893ea9b70ff5368575a75903e190\", \"interactive_ui_tests\": \"9c5d41966b1d0f8ec0b0dedba49b0a5482272ac8\", \"ipc_tests\": \"2773a3aec08323052ff68946b380c0ceafd43e76\", \"jingle_unittests\": \"1284991e63b7cf6ad24c54569310048f6b240aea\", \"latency_unittests\": \"e599be42a7eae09901e39ffe80dd39e705b0e603\", \"libjingle_xmpp_unittests\": \"7656653a147f249cec2aa9be394a900d39bc8a51\", \"liburlpattern_unittests\": \"0e8e5fafbb43970ec41c54a7c41af5ab565a541b\", \"media_blink_unittests\": \"820cdb7f716cd3ec576a095a4de3dd772cd2bdae\", \"media_unittests\": \"2193c230da09e5752f840e90fe8750fafb370f30\", \"message_center_unittests\": \"78e526f2398cea8bc2a7a12d32b0dfd4f258e24c\", \"metrics_python_tests\": \"4ba98ca5ea66a9cf7d36c2ded1bbb24384e7e9ff\", \"midi_unittests\": \"4f7577bc8bfab03eaccee186c50a40786799ac5f\", \"mojo_core_unittests\": \"390ea4b86e7cc17a010413126b611248fb96a973\", \"mojo_unittests\": \"c384ad68c7c460f1c20835bb79e0bd8443cd9cf3\", \"nacl_helper_nonsfi_unittests\": \"50feb20f2ecdd78e1bfc090b1a9e40de2a248413\", \"nacl_loader_unittests\": \"e757c465efa8f5fc6157e63a3533d75cc9b74a4a\", \"native_theme_unittests\": \"c6aaa8a6b2ce6ae70cf9ffeb9e232c261d1230c3\", \"net_unittests\": \"50a494ff8d5df10ea5cbe82b978170fc56664a25\", \"openscreen_unittests\": \"20c63cc821f44a7b6e7d78d60da30e01179d212b\", \"pdf_unittests\": \"37e0963d5d780a23665e73118775569d3ceaa680\", \"perfetto_unittests\": \"3733e98c31477ded41cfdeade917df1cb7e48da3\", \"ppapi_unittests\": \"df16a36d71bd8d579d6d3f396ec70cbc90ffddc3\", \"printing_unittests\": \"2779a6d95ea0e32d9f5ad3db3f69d28202010d57\", \"remoting_unittests\": \"9b3212a4317203fae3378896dd7985d77090f65c\", \"sandbox_linux_unittests\": \"57d66d793828b97f4f7cab452226848a4e5c21ef\", \"service_manager_unittests\": \"616ee49ff45fa3e3b8e9dd9c3d8a6d352656caed\", \"services_unittests\": \"765c13c228727d12df2c44755f3745625010bcb4\", \"shell_dialogs_unittests\": \"e6d56b29f01e7e4df8dfa340f5fad8fedfdc7992\", \"skia_unittests\": \"e0f2694a81f8ad063d1f0913d45a40f474af8e61\", \"snapshot_unittests\": \"d8ac83dcd53e16a55fdae12bf77d2f8111c33a3a\", \"sql_unittests\": \"c10b982a79fe03fd68565583a882eecec3aff635\", \"storage_unittests\": \"6180b30f2acc6a2b92399107fc95906f69f6ec89\", \"sync_integration_tests\": \"7e8350fcb195f20f79f31a1727500fda215b8fc4\", \"telemetry_gpu_unittests\": \"698234111aaebd59998725dc0d168dedd9126b34\", \"telemetry_perf_unittests\": \"b7d2e68ef9e7e0a52d2ec0ddf18f497925ab8e94\", \"telemetry_unittests\": \"d9cfda6ad9d60e5c6b26dfb7346ff628939d0381\", \"traffic_annotation_auditor_unittests\": \"2915ee26f3c0c3a195168e78ef0b2b9896330074\", \"ui_base_unittests\": \"e6c1c15e55bae0adbaacace484af6a1d7921dedc\", \"ui_touch_selection_unittests\": \"6c0f2a94a42fa32767ead4e997989a93d63c592c\", \"unit_tests\": \"1dcbfa8eb22fa60b19cf55ad6087af74e0bbef6f\", \"url_unittests\": \"d937df096d931731ca71edb0eb880465cef5bc4e\", \"views_perftests\": \"dc444aba989e70639e3063333cd02a8a127b4c78\", \"views_unittests\": \"0201abf28a437c46c408d6bf2fda8a88cd7fee6e\", \"viz_unittests\": \"ae755fc8f99a39c640de9cd8b16de4d978ecf959\", \"vr_common_unittests\": \"6eb793fa73daa1442a70313171740ee1614c854c\", \"vr_pixeltests\": \"48bda25a8a6de657262ab8d31553d98699c6e750\", \"webdriver_wpt_tests\": \"ef842d0a23e6eb1bbb8983e999e98392f07e7cbe\", \"weblayer_browsertests\": \"3eef13bb341b36f8bc789df3e23a10193f1d2fcb\", \"weblayer_unittests\": \"c9e67437389baecefc7e59734f5774bf23f746ef\", \"wm_unittests\": \"1320e34ff523d50114df9fad96acca3b3be34191\", \"wtf_unittests\": \"b3a3a6b31b55035c179f717895901bd61b1dce9e\", \"x11_unittests\": \"d13f83a3490fad709dfab7b6e9f9ff912df3270a\", \"xr_browser_tests\": \"bedfa53c4dd9410df7d3d051c8e4891ed80f418c\", \"zlib_unittests\": \"7d14346ed1805b01821d2bb5f1b6e0b7482fced1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_c5a4a77f7d90ed750e2e3c196231723a8f9435afca7311d8fa2536a9dada12e3_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-73-ikou\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607709769128699",
"status": "COMPLETED",
"status_changed_ts": "1607713043160768",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178574",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6194f01f99c4b639e739ef3578a53e2a5d06d55e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026617982365782240",
"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/8861187920361438064/+/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:506bc8954de3dd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607713043168689",
"url": "https://ci.chromium.org/b/8861187920361438064",
"utcnow_ts": "1607713044019735"
}
}
[18:57:24.031] Invocation finished in 55m55.617887503s with status SUCCEEDED