[16:13:38.221] New invocation is queued and will start shortly
[16:13:39.257] Starting the invocation (attempt 1)
[16:13:39.308] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:13:39.308] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:13:39.308] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019920591362938976",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019920591362938976",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"gitiles_ref:refs/heads/master"
]
}
[16:13:40.894] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614096819447549",
"id": "8854490529409801904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614096820738277",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180858",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019920591362938976",
"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/8854490529409801904/+/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": "1614096820738423",
"url": "https://ci.chromium.org/b/8854490529409801904",
"utcnow_ts": "1614096820876956"
}
}
[16:13:40.894] Task URL: https://ci.chromium.org/b/8854490529409801904
[16:13:40.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:2:0) after 1m0s
[16:13:46.358] Received PubSub notification, asking Buildbucket for the build status
[16:13:46.468] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:40.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:2:0)
[16:14:40.946] Timer tick, asking Buildbucket for the build status
[16:14:41.044] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:41.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:4:0) after 1m0s
[16:15:41.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:4:0)
[16:15:41.082] Timer tick, asking Buildbucket for the build status
[16:15:41.347] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:41.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:5:0) after 1m0s
[16:16:41.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:5:0)
[16:16:41.378] Timer tick, asking Buildbucket for the build status
[16:16:41.454] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:41.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:6:0) after 1m0s
[16:17:41.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:6:0)
[16:17:41.522] Timer tick, asking Buildbucket for the build status
[16:17:41.722] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:41.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:7:0) after 1m0s
[16:18:41.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:7:0)
[16:18:41.744] Timer tick, asking Buildbucket for the build status
[16:18:41.898] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:41.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:8:0) after 1m0s
[16:19:42.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:8:0)
[16:19:42.005] Timer tick, asking Buildbucket for the build status
[16:19:42.155] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:42.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:9:0) after 1m0s
[16:20:42.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:9:0)
[16:20:42.223] Timer tick, asking Buildbucket for the build status
[16:20:42.413] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:10:0) after 1m0s
[16:21:42.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:10:0)
[16:21:42.440] Timer tick, asking Buildbucket for the build status
[16:21:42.697] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:42.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:11:0) after 1m0s
[16:22:42.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:11:0)
[16:22:42.680] Timer tick, asking Buildbucket for the build status
[16:22:42.912] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:42.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:12:0) after 1m0s
[16:23:42.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:12:0)
[16:23:42.930] Timer tick, asking Buildbucket for the build status
[16:23:43.011] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:43.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:13:0) after 1m0s
[16:24:43.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:13:0)
[16:24:43.027] Timer tick, asking Buildbucket for the build status
[16:24:43.132] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:43.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:14:0) after 1m0s
[16:25:43.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:14:0)
[16:25:43.156] Timer tick, asking Buildbucket for the build status
[16:25:43.460] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:43.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:15:0) after 1m0s
[16:26:43.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:15:0)
[16:26:43.497] Timer tick, asking Buildbucket for the build status
[16:26:43.899] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:43.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:16:0) after 1m0s
[16:27:43.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:16:0)
[16:27:43.915] Timer tick, asking Buildbucket for the build status
[16:27:43.983] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:17:0) after 1m0s
[16:28:44.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:17:0)
[16:28:44.001] Timer tick, asking Buildbucket for the build status
[16:28:44.074] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:44.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:18:0) after 1m0s
[16:29:44.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:18:0)
[16:29:44.256] Timer tick, asking Buildbucket for the build status
[16:29:44.405] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:44.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:19:0) after 1m0s
[16:30:44.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:19:0)
[16:30:44.464] Timer tick, asking Buildbucket for the build status
[16:30:44.625] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:44.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:20:0) after 1m0s
[16:31:44.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:20:0)
[16:31:44.661] Timer tick, asking Buildbucket for the build status
[16:31:45.221] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:45.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:21:0) after 1m0s
[16:32:45.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:21:0)
[16:32:45.262] Timer tick, asking Buildbucket for the build status
[16:32:45.552] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:22:0) after 1m0s
[16:33:45.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:22:0)
[16:33:45.596] Timer tick, asking Buildbucket for the build status
[16:33:45.884] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:45.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:23:0) after 1m0s
[16:34:45.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:23:0)
[16:34:45.875] Timer tick, asking Buildbucket for the build status
[16:34:46.024] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:46.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:24:0) after 1m0s
[16:35:46.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:24:0)
[16:35:46.078] Timer tick, asking Buildbucket for the build status
[16:35:46.163] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:46.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:25:0) after 1m0s
[16:36:46.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:25:0)
[16:36:46.146] Timer tick, asking Buildbucket for the build status
[16:36:46.242] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:26:0) after 1m0s
[16:37:46.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:26:0)
[16:37:46.339] Timer tick, asking Buildbucket for the build status
[16:37:46.704] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:46.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:27:0) after 1m0s
[16:38:46.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:27:0)
[16:38:46.769] Timer tick, asking Buildbucket for the build status
[16:38:46.852] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:46.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:28:0) after 1m0s
[16:39:47.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:28:0)
[16:39:47.076] Timer tick, asking Buildbucket for the build status
[16:39:47.241] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:47.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:29:0) after 1m0s
[16:40:47.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:29:0)
[16:40:47.346] Timer tick, asking Buildbucket for the build status
[16:40:47.614] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:47.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:30:0) after 1m0s
[16:41:47.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:30:0)
[16:41:47.698] Timer tick, asking Buildbucket for the build status
[16:41:47.849] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:47.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:31:0) after 1m0s
[16:42:47.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:31:0)
[16:42:47.829] Timer tick, asking Buildbucket for the build status
[16:42:48.114] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:48.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:32:0) after 1m0s
[16:43:48.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:32:0)
[16:43:48.154] Timer tick, asking Buildbucket for the build status
[16:43:48.247] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:48.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:33:0) after 1m0s
[16:44:48.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:33:0)
[16:44:48.268] Timer tick, asking Buildbucket for the build status
[16:44:48.514] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:48.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:34:0) after 1m0s
[16:45:48.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:34:0)
[16:45:48.579] Timer tick, asking Buildbucket for the build status
[16:45:48.882] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:48.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:35:0) after 1m0s
[16:46:48.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:35:0)
[16:46:48.906] Timer tick, asking Buildbucket for the build status
[16:46:49.089] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:49.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:36:0) after 1m0s
[16:47:49.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:36:0)
[16:47:49.072] Timer tick, asking Buildbucket for the build status
[16:47:49.225] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:49.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:37:0) after 1m0s
[16:48:49.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:37:0)
[16:48:49.251] Timer tick, asking Buildbucket for the build status
[16:48:49.347] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:49.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:38:0) after 1m0s
[16:49:49.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:38:0)
[16:49:49.430] Timer tick, asking Buildbucket for the build status
[16:49:49.551] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:49.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:39:0) after 1m0s
[16:50:49.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:39:0)
[16:50:49.603] Timer tick, asking Buildbucket for the build status
[16:50:49.718] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:40:0) after 1m0s
[16:51:49.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:40:0)
[16:51:49.765] Timer tick, asking Buildbucket for the build status
[16:51:49.983] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:49.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:41:0) after 1m0s
[16:52:50.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:41:0)
[16:52:50.093] Timer tick, asking Buildbucket for the build status
[16:52:50.360] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:50.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:42:0) after 1m0s
[16:53:50.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:42:0)
[16:53:50.420] Timer tick, asking Buildbucket for the build status
[16:53:50.488] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:50.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:43:0) after 1m0s
[16:54:50.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:43:0)
[16:54:50.525] Timer tick, asking Buildbucket for the build status
[16:54:50.633] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:50.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:44:0) after 1m0s
[16:55:50.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:44:0)
[16:55:50.711] Timer tick, asking Buildbucket for the build status
[16:55:50.790] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:50.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:45:0) after 1m0s
[16:56:50.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:45:0)
[16:56:50.793] Timer tick, asking Buildbucket for the build status
[16:56:50.875] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:50.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:46:0) after 1m0s
[16:57:50.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:46:0)
[16:57:50.963] Timer tick, asking Buildbucket for the build status
[16:57:51.100] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:51.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:47:0) after 1m0s
[16:58:51.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:47:0)
[16:58:51.169] Timer tick, asking Buildbucket for the build status
[16:58:51.360] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:51.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:48:0) after 1m0s
[16:59:51.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:48:0)
[16:59:51.468] Timer tick, asking Buildbucket for the build status
[16:59:51.690] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:51.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:49:0) after 1m0s
[17:00:51.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:49:0)
[17:00:51.739] Timer tick, asking Buildbucket for the build status
[17:00:51.999] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:51.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:50:0) after 1m0s
[17:01:52.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:50:0)
[17:01:52.080] Timer tick, asking Buildbucket for the build status
[17:01:52.520] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:52.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:51:0) after 1m0s
[17:02:52.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:51:0)
[17:02:52.626] Timer tick, asking Buildbucket for the build status
[17:02:52.778] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:52.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:52:0) after 1m0s
[17:03:52.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:52:0)
[17:03:52.891] Timer tick, asking Buildbucket for the build status
[17:03:52.991] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:52.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:53:0) after 1m0s
[17:04:53.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:53:0)
[17:04:53.062] Timer tick, asking Buildbucket for the build status
[17:04:53.185] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:53.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:54:0) after 1m0s
[17:05:53.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:54:0)
[17:05:53.271] Timer tick, asking Buildbucket for the build status
[17:05:53.376] Build 8854490529409801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019920591362938976:55:0) after 1m0s
[17:06:14.654] Received PubSub notification, asking Buildbucket for the build status
[17:06:14.964] Build 8854490529409801904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:06:14.964] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614099973783289",
"created_by": "project:chromium",
"created_ts": "1614096819447549",
"id": "8854490529409801904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\"}}",
"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\": \"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\", \"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-174-0eo1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180858, \"got_angle_revision\": \"1a70e5a04584ce3586c9ce7243b419f0df7b052f\", \"got_dawn_revision\": \"76a94b17be3c6cfc7e88d30b90e99d7b89c8f30b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\", \"got_revision_cp\": \"refs/heads/master@{#856701}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"4120b5f2509821e8dd460b1d033708397520750a\", \"got_v8_revision_cp\": \"refs/heads/9.0.238@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"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\": \"6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957\", \"swarm_hashes_refs/heads/master(at){#856701}_without_patch\": {\"absl_hardening_tests\": \"44fcb2b6e4cdc0642eea4c460ac5d9b5d4c8f34f\", \"accessibility_unittests\": \"0777a44a6ad553cd90a66323245d52f38ba4defa\", \"angle_unittests\": \"3e4983e1f46861447ca426ccdeec37a2cf9de22a\", \"app_shell_unittests\": \"23b44db5b8f50e520524198a0ad70fd60b6261ce\", \"aura_unittests\": \"8ccc3fcce1617c6655226a5cf8fcf69dd753dad1\", \"base_unittests\": \"ef4dbe3b5d7259691478234aad88ccac62561c23\", \"base_util_unittests\": \"30f268bb0f93b36921762cf06ed7ba0c6b9558c2\", \"blink_common_unittests\": \"c9a72ef521873be7c007648d17a255bfb6c63ca9\", \"blink_fuzzer_unittests\": \"0cf6874c89911f11971d2e709f730f546262ae21\", \"blink_heap_unittests\": \"28a5e52b7cfa7c5a7081f71d4dc3603c1aa91de5\", \"blink_platform_unittests\": \"5335289bdf4350fd89547a1f9d36f5fa823c3490\", \"blink_python_tests\": \"c5ccb343c1ac8e74bb705f22e3514f258afaf843\", \"blink_unittests\": \"bf12966bd710114726f50205eaf9ef50663fa336\", \"blink_web_tests\": \"45e076bca88bb01c6250f7b1961137f545993221\", \"boringssl_crypto_tests\": \"1fe69276b84069fad69a54e0872c9a1c7f085b31\", \"boringssl_ssl_tests\": \"2216409ae5bc7366bc7ff8a8fe3256eda1129c68\", \"browser_tests\": \"7f4d21631551ad7fccb812966471851603280c58\", \"capture_unittests\": \"68a10dbefe2c085b6f1211e66fec6eae91a62daa\", \"cast_unittests\": \"1e8c017a5b1160853973f6b3e2893c882a10c933\", \"cc_unittests\": \"f2908ac25813c57a2463f9371b913177ca39d437\", \"chrome_app_unittests\": \"c4cf992d677ca9fb13545a93943a8cde57143b48\", \"chromedriver_unittests\": \"6b80fcd6dad0ce3245e6bd8e570d69d35821c8c8\", \"components_browsertests\": \"83a7060002e5dd1d9007bb78f1df924b5a9480df\", \"components_unittests\": \"1568a5df319b70ed5189a9e40a7f5ec2cbc33e4d\", \"compositor_unittests\": \"4b6679788e8016f92c6e0ed2d879e41faf34db68\", \"content_browsertests\": \"43b3f5b6587e0395f1ea0d0ba42d8dc964b97745\", \"content_shell_crash_test\": \"9e272cf202006b218d66e7ad4028dd8a736cf05c\", \"content_unittests\": \"f95edf403c47179d8fe8b12f262796589c75725d\", \"crashpad_tests\": \"15c9829084870c80ee403e6269b5c0cf1023173c\", \"cronet_tests\": \"a75fa24b938c4325159250d6d782c49fadf1b8f5\", \"cronet_unittests\": \"7d9e400120c3ca4223fd7139a7336124d2ef2160\", \"crypto_unittests\": \"a2778b207558572d7942149d7dfb38ce99f7ccb0\", \"dbus_unittests\": \"c6d8c8a3a2e51e978639cda671ab8adcd6ab0d45\", \"device_unittests\": \"ad78ebc0b7659f33e97d60281bf5c4757b5a7ef0\", \"display_unittests\": \"69e6c103d6f267349d84c1062707c9201afc4f79\", \"events_unittests\": \"0f973d8c1fc4bf689ef624448f0f580bd9c63b00\", \"extensions_browsertests\": \"71041c8c85d0dc4fabe427f5c3b94beabccaf449\", \"extensions_unittests\": \"09e677f6c55b7f1e9e9d4371a6d10f0b5e4f01be\", \"filesystem_service_unittests\": \"7942ab7210469ef0dfd5e65b754fac0e68ab8ee3\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"59cc9696757114f7ceb234c09906a90ca2513981\", \"gfx_unittests\": \"b94861c8354657d75c167f6f4e1b73caf97c712c\", \"gin_unittests\": \"9f7d70a979ea30af9276ec3a8601ee4ccc0bffd9\", \"google_apis_unittests\": \"3a31b4cbfc1127dbe81698e9c5c8197ce75a696a\", \"gpu_unittests\": \"c281ad576c748ab559afe4c7fd6acc6806a3688e\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"f90931ef7d1ae55aaac9b1bb5f51860f0096fbc5\", \"headless_browsertests\": \"bf99b77ed0d904c3c18f95d1715ac61fff7ad9ab\", \"headless_unittests\": \"23f9929a36bdb82d972eedb93b6c309e5480dd65\", \"interactive_ui_tests\": \"9bcd975dd0b045202bf9d85e3f3a3f0d51f168d9\", \"ipc_tests\": \"0ca61430c730385197217de2fe8c027f0c473b6d\", \"jingle_unittests\": \"0fbd29e26302b73632ba7091a183b62f1f85aad0\", \"latency_unittests\": \"e15cdabd142ef60247f9095013e2b367f7f7f5c0\", \"libjingle_xmpp_unittests\": \"6de09c8a314445b2b8b1c3308bf8d4baf64112e5\", \"liburlpattern_unittests\": \"6ae2d3b7b8ddb779a1b8e0efdb60149d3a567a61\", \"media_blink_unittests\": \"5642e455f83076ec7ed4de220b75a90bf9d5d8af\", \"media_unittests\": \"2b3a59bc355a135bda69eebf7235ef4a8687fba4\", \"message_center_unittests\": \"e3dd8e23e3a8c5c2405717cbb999b78d9cea0dc1\", \"metrics_python_tests\": \"e6d2a9fe6259aaab343034247a81ed9107a525e5\", \"midi_unittests\": \"c02dfe1307306e6a2ff70de11ab761306cb34c11\", \"mojo_core_unittests\": \"6c2532d95aec14ca5be1ee401abe83eca4f26cad\", \"mojo_unittests\": \"8793c78265c7b3a7f045f1c74a0718056f9ba3dd\", \"nacl_helper_nonsfi_unittests\": \"caaef92d130650aaa5210b099e89508deb91c5b3\", \"nacl_loader_unittests\": \"7823e1332ca1835f59bb476f77414edf9a66bee9\", \"native_theme_unittests\": \"4dc85b7831c53b1586e2d93079ed053e0121fb1c\", \"net_unittests\": \"bc617810f7614f1b367c9fef81d8e36a2cb01b4e\", \"openscreen_unittests\": \"0f45a2746e74b956dcbadd06ad9dd6b593b78613\", \"pdf_unittests\": \"140d9513a561fcbb2b61acb6c2ddd92c90f6069c\", \"perfetto_unittests\": \"8bb386e2c173c8fea39d10d401297a26c0fd93ce\", \"ppapi_unittests\": \"b92659bf1a0a79cd0ecd4240f05e73be317b4f1c\", \"printing_unittests\": \"04dc3e5d6e604132bbd6156fcd6078708748abaf\", \"remoting_unittests\": \"1f43f53b6db2586fcb2f5007171e9e650b0e973a\", \"sandbox_linux_unittests\": \"626478cd181785e37cded4094719b167e86605e0\", \"service_manager_unittests\": \"4a81955f02a1bb968a4474de18fa9ae6c999045d\", \"services_unittests\": \"e507aee2b088ffd65ba521dede7ecaef48eca7a9\", \"shell_dialogs_unittests\": \"cbdf737eb513ec4e446c017047f261cd0c936f61\", \"skia_unittests\": \"1a94d78ea27400211c45717f19f60a4820b3ff67\", \"snapshot_unittests\": \"e7987952e702f53066fdd2a743b48240f51ce144\", \"sql_unittests\": \"40311dd6ea8b7f379ee0a46dcdf09d73d0abfec6\", \"storage_unittests\": \"028fa793080da0beb42de6bbd447a232a6ff44a6\", \"sync_integration_tests\": \"98008013e0208c14b07e940f3b0782a70c4be0d9\", \"telemetry_gpu_unittests\": \"7844ba5bf580d52f0b80e97f8234f7cfab308e53\", \"telemetry_perf_unittests\": \"f5879b2ccad82816915686b7ae8a1012bac325b2\", \"telemetry_unittests\": \"597c599824548dba7f5490b7c734b688ad69ad5f\", \"traffic_annotation_auditor_unittests\": \"1af4321602001173a06c0e2d96a3aa2c492352b9\", \"ui_base_unittests\": \"ac1d962eaea87482f66aa4182f719b9100e3397f\", \"ui_touch_selection_unittests\": \"f0bd31f063fe9dc14aed406556c146a6fffcc033\", \"unit_tests\": \"9e8e174196c93f0b34ed6ebfdcb977f10f24ac44\", \"url_unittests\": \"eced9c281db1ad99202888f792e5b08ffc5661a9\", \"views_perftests\": \"d6cf4945be7b3258db22e396e77451bf129958bf\", \"views_unittests\": \"ef5b5856f06873ea32bb162e7f688d24e0ebf2cb\", \"viz_unittests\": \"e6d1f447c7b5b037e5bb60003b7253e4ba14be29\", \"vr_common_unittests\": \"0e1cfe9b15ea0deb1afef092095ce3f3a16ca271\", \"vr_pixeltests\": \"791f291c0db579cd278c3af7f9cfdf7fc6281a72\", \"webdriver_wpt_tests\": \"5e158d83d12b847bbc6866cc06ea72e87f190584\", \"weblayer_browsertests\": \"3ecacded7802815fa33f114852ae892187a99930\", \"weblayer_unittests\": \"d05eba54933bcbeb79278b460bf2f91718e99fcb\", \"wm_unittests\": \"1bd60ef01297580ee9d89dca227883da9e10afa8\", \"wtf_unittests\": \"d6948b0948f33f5df368d08bb662809f7e6124e3\", \"x11_unittests\": \"bac190df17ebc267d98fea84e5657cae8efa35c5\", \"xr_browser_tests\": \"e020b483567105f38b98b98e11bc8f34dff1be34\", \"zlib_unittests\": \"7fe798482749177223c15c9436fd327061e9efd1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_53a369b6e7b3f2409540d71b27a68c8bcf1cb73633e70dba0b4b8b173a0aec5e_v2\", \"builder_bf60de3a2a061c3c4c67ad9afdde23d2342e42cdda6e8a4003b52312ca24fd40_v2\", \"builder_c66788656bdf2acb3179f9105d1e02eee4c98139f3cebcabd373c722039a64ae_v2\", \"builder_ce300ca2149b7ede2a11dc5f29b170d3e5c2bdd2b201177604ba7c6bb221adeb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-174-0eo1\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614096824507614",
"status": "COMPLETED",
"status_changed_ts": "1614099974126101",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180858",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ecfc88b5bb4a8bd36990f3467b9e5c67ba7f957",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019920591362938976",
"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/8854490529409801904/+/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:51e87c77426e3210",
"user_agent:luci-scheduler"
],
"updated_ts": "1614099974134858",
"url": "https://ci.chromium.org/b/8854490529409801904",
"utcnow_ts": "1614099974912180"
}
}
[17:06:14.964] Invocation finished in 52m36.763318542s with status SUCCEEDED