[04:21:30.976] New invocation is queued and will start shortly
[04:21:32.100] Starting the invocation (attempt 1)
[04:21:32.138] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:21:32.138] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:21:32.138] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022502109181154576",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"be50eb7522a7bf9e52c40134bbcadff798a4deb7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022502109181154576",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"gitiles_ref:refs/heads/master"
]
}
[04:21:32.790] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611634892242834",
"id": "8857072047190795600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"be50eb7522a7bf9e52c40134bbcadff798a4deb7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611634892640230",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179981",
"builder:Linux Builder (dbg)",
"buildset:commit/git/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022502109181154576",
"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/8857072047190795600/+/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": "1611634892640351",
"url": "https://ci.chromium.org/b/8857072047190795600",
"utcnow_ts": "1611634892783091"
}
}
[04:21:32.790] Task URL: https://ci.chromium.org/b/8857072047190795600
[04:21:32.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:2:0) after 1m0s
[04:22:06.176] Received PubSub notification, asking Buildbucket for the build status
[04:22:06.301] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:32.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:2:0)
[04:22:32.833] Timer tick, asking Buildbucket for the build status
[04:22:32.947] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:32.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:4:0) after 1m0s
[04:23:33.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:4:0)
[04:23:33.029] Timer tick, asking Buildbucket for the build status
[04:23:33.153] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:5:0) after 1m0s
[04:24:33.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:5:0)
[04:24:33.196] Timer tick, asking Buildbucket for the build status
[04:24:33.405] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:33.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:6:0) after 1m0s
[04:25:33.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:6:0)
[04:25:33.540] Timer tick, asking Buildbucket for the build status
[04:25:33.655] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:33.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:7:0) after 1m0s
[04:26:33.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:7:0)
[04:26:33.785] Timer tick, asking Buildbucket for the build status
[04:26:33.880] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:33.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:8:0) after 1m0s
[04:27:33.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:8:0)
[04:27:33.980] Timer tick, asking Buildbucket for the build status
[04:27:34.302] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:9:0) after 1m0s
[04:28:34.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:9:0)
[04:28:34.358] Timer tick, asking Buildbucket for the build status
[04:28:34.759] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:34.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:10:0) after 1m0s
[04:29:34.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:10:0)
[04:29:34.772] Timer tick, asking Buildbucket for the build status
[04:29:34.844] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:34.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:11:0) after 1m0s
[04:30:34.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:11:0)
[04:30:34.919] Timer tick, asking Buildbucket for the build status
[04:30:35.018] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:12:0) after 1m0s
[04:31:35.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:12:0)
[04:31:35.022] Timer tick, asking Buildbucket for the build status
[04:31:35.125] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:35.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:13:0) after 1m0s
[04:32:35.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:13:0)
[04:32:35.152] Timer tick, asking Buildbucket for the build status
[04:32:35.217] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:14:0) after 1m0s
[04:33:35.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:14:0)
[04:33:35.324] Timer tick, asking Buildbucket for the build status
[04:33:35.402] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:35.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:15:0) after 1m0s
[04:34:35.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:15:0)
[04:34:35.473] Timer tick, asking Buildbucket for the build status
[04:34:35.582] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:16:0) after 1m0s
[04:35:35.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:16:0)
[04:35:35.593] Timer tick, asking Buildbucket for the build status
[04:35:35.647] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:35.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:17:0) after 1m0s
[04:36:35.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:17:0)
[04:36:35.765] Timer tick, asking Buildbucket for the build status
[04:36:35.884] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:35.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:18:0) after 1m0s
[04:37:35.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:18:0)
[04:37:35.933] Timer tick, asking Buildbucket for the build status
[04:37:36.001] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:19:0) after 1m0s
[04:38:36.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:19:0)
[04:38:36.041] Timer tick, asking Buildbucket for the build status
[04:38:36.103] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:36.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:20:0) after 1m0s
[04:39:36.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:20:0)
[04:39:36.127] Timer tick, asking Buildbucket for the build status
[04:39:36.209] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:21:0) after 1m0s
[04:40:36.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:21:0)
[04:40:36.296] Timer tick, asking Buildbucket for the build status
[04:40:36.523] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:36.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:22:0) after 1m0s
[04:41:36.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:22:0)
[04:41:36.512] Timer tick, asking Buildbucket for the build status
[04:41:36.611] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:23:0) after 1m0s
[04:42:36.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:23:0)
[04:42:36.646] Timer tick, asking Buildbucket for the build status
[04:42:36.732] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:24:0) after 1m0s
[04:43:36.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:24:0)
[04:43:36.881] Timer tick, asking Buildbucket for the build status
[04:43:37.018] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:25:0) after 1m0s
[04:44:37.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:25:0)
[04:44:37.051] Timer tick, asking Buildbucket for the build status
[04:44:37.168] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:37.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:26:0) after 1m0s
[04:45:37.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:26:0)
[04:45:37.214] Timer tick, asking Buildbucket for the build status
[04:45:37.274] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:37.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:27:0) after 1m0s
[04:46:37.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:27:0)
[04:46:37.361] Timer tick, asking Buildbucket for the build status
[04:46:37.462] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:28:0) after 1m0s
[04:47:37.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:28:0)
[04:47:37.501] Timer tick, asking Buildbucket for the build status
[04:47:37.580] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:37.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:29:0) after 1m0s
[04:48:37.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:29:0)
[04:48:37.627] Timer tick, asking Buildbucket for the build status
[04:48:37.685] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:37.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:30:0) after 1m0s
[04:49:38.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:30:0)
[04:49:38.212] Timer tick, asking Buildbucket for the build status
[04:49:38.338] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:38.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:31:0) after 1m0s
[04:50:38.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:31:0)
[04:50:38.571] Timer tick, asking Buildbucket for the build status
[04:50:38.653] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:38.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:32:0) after 1m0s
[04:51:38.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:32:0)
[04:51:38.741] Timer tick, asking Buildbucket for the build status
[04:51:38.884] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:33:0) after 1m0s
[04:52:39.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:33:0)
[04:52:39.045] Timer tick, asking Buildbucket for the build status
[04:52:39.118] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:39.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:34:0) after 1m0s
[04:53:39.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:34:0)
[04:53:39.173] Timer tick, asking Buildbucket for the build status
[04:53:39.502] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:39.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:35:0) after 1m0s
[04:54:39.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:35:0)
[04:54:39.527] Timer tick, asking Buildbucket for the build status
[04:54:39.649] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:39.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:36:0) after 1m0s
[04:55:39.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:36:0)
[04:55:39.695] Timer tick, asking Buildbucket for the build status
[04:55:39.784] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:39.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:37:0) after 1m0s
[04:56:39.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:37:0)
[04:56:39.890] Timer tick, asking Buildbucket for the build status
[04:56:40.868] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:40.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:38:0) after 1m0s
[04:57:40.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:38:0)
[04:57:40.878] Timer tick, asking Buildbucket for the build status
[04:57:40.962] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:40.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:39:0) after 1m0s
[04:58:40.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:39:0)
[04:58:40.990] Timer tick, asking Buildbucket for the build status
[04:58:41.080] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:41.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:40:0) after 1m0s
[04:59:41.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:40:0)
[04:59:41.173] Timer tick, asking Buildbucket for the build status
[04:59:41.426] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:41.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:41:0) after 1m0s
[05:00:41.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:41:0)
[05:00:41.450] Timer tick, asking Buildbucket for the build status
[05:00:41.537] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:41.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:42:0) after 1m0s
[05:01:41.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:42:0)
[05:01:41.558] Timer tick, asking Buildbucket for the build status
[05:01:41.799] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:41.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:43:0) after 1m0s
[05:02:41.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:43:0)
[05:02:41.873] Timer tick, asking Buildbucket for the build status
[05:02:42.041] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:42.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:44:0) after 1m0s
[05:03:42.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:44:0)
[05:03:42.188] Timer tick, asking Buildbucket for the build status
[05:03:42.323] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:42.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:45:0) after 1m0s
[05:04:42.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:45:0)
[05:04:42.346] Timer tick, asking Buildbucket for the build status
[05:04:42.495] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:42.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:46:0) after 1m0s
[05:05:42.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:46:0)
[05:05:42.559] Timer tick, asking Buildbucket for the build status
[05:05:43.023] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:43.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:47:0) after 1m0s
[05:06:43.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:47:0)
[05:06:43.053] Timer tick, asking Buildbucket for the build status
[05:06:43.173] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:43.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:48:0) after 1m0s
[05:07:43.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:48:0)
[05:07:43.193] Timer tick, asking Buildbucket for the build status
[05:07:43.267] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:43.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:49:0) after 1m0s
[05:08:43.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:49:0)
[05:08:43.285] Timer tick, asking Buildbucket for the build status
[05:08:43.464] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:43.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:50:0) after 1m0s
[05:09:43.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:50:0)
[05:09:43.531] Timer tick, asking Buildbucket for the build status
[05:09:43.595] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:43.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:51:0) after 1m0s
[05:10:43.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:51:0)
[05:10:43.647] Timer tick, asking Buildbucket for the build status
[05:10:43.726] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:43.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:52:0) after 1m0s
[05:11:43.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:52:0)
[05:11:43.829] Timer tick, asking Buildbucket for the build status
[05:11:44.123] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:44.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:53:0) after 1m0s
[05:12:44.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:53:0)
[05:12:44.117] Timer tick, asking Buildbucket for the build status
[05:12:44.287] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:44.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:54:0) after 1m0s
[05:13:44.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:54:0)
[05:13:44.382] Timer tick, asking Buildbucket for the build status
[05:13:44.509] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:44.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:55:0) after 1m0s
[05:14:44.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:55:0)
[05:14:44.535] Timer tick, asking Buildbucket for the build status
[05:14:44.606] Build 8857072047190795600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:44.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022502109181154576:56:0) after 1m0s
[05:15:02.433] Received PubSub notification, asking Buildbucket for the build status
[05:15:02.502] Build 8857072047190795600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:15:02.502] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611638101619341",
"created_by": "project:chromium",
"created_ts": "1611634892242834",
"id": "8857072047190795600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"be50eb7522a7bf9e52c40134bbcadff798a4deb7\"}}",
"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\": \"be50eb7522a7bf9e52c40134bbcadff798a4deb7\", \"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-61-156b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179981, \"got_angle_revision\": \"9bbcd86ae719866273598c988709c7ec3d462e1d\", \"got_dawn_revision\": \"73668344d656e4bad2f6a1dd75c85ffae1e56973\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"be50eb7522a7bf9e52c40134bbcadff798a4deb7\", \"got_revision_cp\": \"refs/heads/master@{#847051}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"99e54b1c5caf06a25f76faa4c20c9ab1b31bdb61\", \"got_v8_revision\": \"28f6c291a22caef35a8cf0b58ed0889dc8152903\", \"got_v8_revision_cp\": \"refs/heads/9.0.68@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"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\": \"be50eb7522a7bf9e52c40134bbcadff798a4deb7\", \"swarm_hashes_refs/heads/master(at){#847051}_without_patch\": {\"absl_hardening_tests\": \"9684ab6be75b01321415f2c40b6a1c4749998cd6\", \"accessibility_unittests\": \"ec314bf722f5f0b3fbd66aefa81be4d0490647d2\", \"angle_unittests\": \"04b109e95b62460849bd7a79232aeb5a9da78e5f\", \"app_shell_unittests\": \"fceb17355a0372505940a456011ba4b6707bebb7\", \"aura_unittests\": \"567202d316b14aa6a27cfd4154a577431403a470\", \"base_unittests\": \"91af9de40e58124e604cafe9703bb4b563febca3\", \"base_util_unittests\": \"fc0826f314dd4aa18bf62096dd67007af726ad25\", \"blink_common_unittests\": \"dbb799152449f138ef1a50d862a44ebf93f9c917\", \"blink_fuzzer_unittests\": \"ab1a8b8a8e3eec91c5d2f6d591cd7af7590a62c9\", \"blink_heap_unittests\": \"71d9207adae736dfb1695866f30ba82e2a53328e\", \"blink_platform_unittests\": \"78239c464e5aea8a2a6dc3d67fc1d4086843f600\", \"blink_python_tests\": \"4e0048adae73c025c96f8877b4cd95f247b23969\", \"blink_unittests\": \"43f332529a1551302c0352e4edf6219c22fffc4d\", \"blink_web_tests\": \"e3ad3c215a522c60b75e0205745eedf576e1401a\", \"boringssl_crypto_tests\": \"9948359f2c735f08e04485668af93ca3b8af7cfb\", \"boringssl_ssl_tests\": \"1b85ce8a490860b1e4e498e9ece8188f07cac535\", \"browser_tests\": \"9e317c13d6324a1db5d6b23a6281a5fe1a5d3d5a\", \"capture_unittests\": \"ad6a41a9cf94f68bca607b7b0836f2d64ed1b935\", \"cast_unittests\": \"585642ff378a0ca4fda5e006aca3bd12c6b532c6\", \"cc_unittests\": \"d4027043858dc9408fcf88bea280d7cbceed73e1\", \"chrome_app_unittests\": \"bf6f185bb8268b6a2208844a1dfa50a58cf85e3f\", \"chromedriver_unittests\": \"bacf0664bec1e630c2abbbd61328c50aff2ffdae\", \"components_browsertests\": \"50e6140f03c4c63872f679933039adf09d6534b8\", \"components_unittests\": \"bb8b90438a6eb0bf284d71644543429b42493165\", \"compositor_unittests\": \"2c877a754346afcb2f2cc706959e61782c846f64\", \"content_browsertests\": \"16e855afdf7c0572d5a241ae2195f72090780cfb\", \"content_shell_crash_test\": \"579937fc820f17be89457d1d704a3f3c963decc8\", \"content_unittests\": \"cde3949353d98d64e70e90a86c7032b2d61c8640\", \"crashpad_tests\": \"c5bb6982151a66ef585d3e07dab5345f12243904\", \"cronet_tests\": \"48aefba5f1b321382004b8a2c2ce85c843574f70\", \"cronet_unittests\": \"ef713aebad91cb3a952433008ae5a74ab4c299f6\", \"crypto_unittests\": \"d541b6b5300bef7a15657040a1dffbf206615736\", \"dbus_unittests\": \"380ee42d7bf2c1b5d3662f61bb06403f705cc16f\", \"device_unittests\": \"6da4d59dd8f05f62a448c588130678eba92250b6\", \"display_unittests\": \"565ca323d0d72ed7cc83cf21c54c3b89ba90479a\", \"events_unittests\": \"f862ea26e7c853b1cdf3b745aad00b6909dd2453\", \"extensions_browsertests\": \"2eda671092f037ded0b08d06792c0e9da4557947\", \"extensions_unittests\": \"f55c51f4443f3b3295db482f81197b578969afa4\", \"filesystem_service_unittests\": \"bb714385a10ff42a37214a2e3bde3ffc48ea836a\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"dfd322c5ee6128df9db5699124d43db187096a48\", \"gfx_unittests\": \"66e803a1d11f6e6cba652da6bea84603fa2792b8\", \"gin_unittests\": \"ce24cc7d2420b7179d88663502f087f058820d1c\", \"google_apis_unittests\": \"d171f5a25e6f8df4a28443686acb6722f4d49dd3\", \"gpu_unittests\": \"44c1488a079b4cda891846eeba55597a8f3ecdb4\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"66793ccf34155e6bab10e7069a46bc05f533cb66\", \"headless_browsertests\": \"a116eb90b009f4c21d21a0c573cf72b838a6e5aa\", \"headless_unittests\": \"d44630bd49e9151c496efc73cb7acc615c13fdea\", \"interactive_ui_tests\": \"4601901700283f695d7ff770b6551bea15080fb5\", \"ipc_tests\": \"5ae125ad4e992b7abd7829fcb38e254e4e4c5e2e\", \"jingle_unittests\": \"901f67a5933a8b1b33e52df603693073f8b72e5b\", \"latency_unittests\": \"2b30e2d7c739ac52df889e083aaa5fd02ac165ba\", \"libjingle_xmpp_unittests\": \"d16efb5a3ef73b6b06425cf37c13da5cbc0ac39e\", \"liburlpattern_unittests\": \"dcba2436ddd9d30f215149650fc524ffc3f3c53c\", \"media_blink_unittests\": \"973b125e8e8a3aaad166ee8b24f3866219e9a557\", \"media_unittests\": \"784e4e2261c6361aa9c88032e56658da63c4a99a\", \"message_center_unittests\": \"d05af5d2c2c10b2ae995f2035022f1532a018a18\", \"metrics_python_tests\": \"329e801e819c3df15b49e1dfa296fd2ecd197b8d\", \"midi_unittests\": \"60388665f2da560f43baa6678d59ccf3d2721df7\", \"mojo_core_unittests\": \"92cb00258ff355894722dd97c979971cdb9bc1e3\", \"mojo_unittests\": \"781d3340fa21e9ed0a8b2de26a536366329d5570\", \"nacl_helper_nonsfi_unittests\": \"7cdce20f8a7aa808cdb69040964a7434a5a583a9\", \"nacl_loader_unittests\": \"331683d8c17c67e77e38c5c4f32a01d63ebb216d\", \"native_theme_unittests\": \"5dbf53e400674787acdde388fa94d36563b25c02\", \"net_unittests\": \"060cb52096e2ed24ef4e234c950a1efa1f103567\", \"openscreen_unittests\": \"6f32d6b066b048946e1f13914cd58283c757b3d8\", \"pdf_unittests\": \"dfafd4d9f02ece9c05acd3042301ff1d37cb9c51\", \"perfetto_unittests\": \"60f8f1ec64b83228e3621d17372766d88cb43579\", \"ppapi_unittests\": \"e2289f00425e5308b60938512ca4d6a2b50c489b\", \"printing_unittests\": \"6fc5bdcb916126604836ada7d54cbd9e895cf4d8\", \"remoting_unittests\": \"54fd0c9f53139f0a8402c62714cf2733d8f4a9e6\", \"sandbox_linux_unittests\": \"427f1b12cfbd98bff817c7457344655fdfa12fe7\", \"service_manager_unittests\": \"c716d4da9c0ed9f8953123aaf2c8263b6541f616\", \"services_unittests\": \"0df8e3ab816a8697162617d3a6da85ad890a6d99\", \"shell_dialogs_unittests\": \"f896f1edf62cca1484656ea0c0b865180d939edf\", \"skia_unittests\": \"9d0e6f31a8a4d21b52d613306116d93477168eb8\", \"snapshot_unittests\": \"f6b9da337b95b6ec78ccd741555e723a0aa8dd5b\", \"sql_unittests\": \"2743d6a6b1b50a331ede7683b108eb93484fabb8\", \"storage_unittests\": \"8078c01a8d8e6a6be547f20ff4f25c8ac24b3852\", \"sync_integration_tests\": \"339305e5baa741ede1194d37b58668e16f74c837\", \"telemetry_gpu_unittests\": \"cc3383938d3236c9f4cba85501f0b993f23d4ac6\", \"telemetry_perf_unittests\": \"b0136d4f94dafdb941d9e6691502f96ba9cf46ed\", \"telemetry_unittests\": \"dcf355f5311523c80ded072a6b40add04c44fbfc\", \"traffic_annotation_auditor_unittests\": \"4f6f28ce22d5af227096ecf68c814b0021f30485\", \"ui_base_unittests\": \"e3047251d86d76b60d6e137d0976f2c064caa2a2\", \"ui_touch_selection_unittests\": \"1cd0868f03de867099870724cce6df04ba6b18ad\", \"unit_tests\": \"b9fe0061cf996ccfba4fd9f97b160484f80227f5\", \"url_unittests\": \"3f160a8f6e04ffd05dad9903cba781fa889e5c09\", \"views_perftests\": \"87a434384c9bbe71bb4e3e5909123c8eca991728\", \"views_unittests\": \"76cd44b006f36347b51fb7627245ff11742001da\", \"viz_unittests\": \"84c85be341d5603ca8389df5442a2b8573304255\", \"vr_common_unittests\": \"af53a8fd21d83fb9e7ebad23bea6836a1b8be2f2\", \"vr_pixeltests\": \"e6a780263b957091417d9088f755248201a8cea2\", \"webdriver_wpt_tests\": \"e77fc06be9834b0a334eb7c1fc7ce8f85fd4160a\", \"weblayer_browsertests\": \"4663378852f1501498d036953f3b8080c75c6264\", \"weblayer_unittests\": \"472a8a8e78789d41f3e711a1e1694f8339f111da\", \"wm_unittests\": \"3fb015a0723515494bc9ae4b45be7abc066ccb01\", \"wtf_unittests\": \"1d64bacf26b6ca2ab7e4d28884d753015f0f8228\", \"x11_unittests\": \"6d1d42940126ec39d49b71bf23e6f01f348b3ad9\", \"xr_browser_tests\": \"6eaeae6c37f366a9b90db5032e41f3ec3bdd8147\", \"zlib_unittests\": \"8a110fd9bef3a4af13d585c66591c7e06f2a7217\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a68a9f55474b9b0de9a1b5508ecffb4a5d0899362fc191acd472d4c557fdb4e8_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_dd9616d41d89d2602800dfeda62c5b43a746c971e6e18e9b0c84ab0482a0e409_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-61-156b\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611634925333660",
"status": "COMPLETED",
"status_changed_ts": "1611638102110463",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179981",
"builder:Linux Builder (dbg)",
"buildset:commit/git/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be50eb7522a7bf9e52c40134bbcadff798a4deb7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022502109181154576",
"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/8857072047190795600/+/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:5155be6896fda310",
"user_agent:luci-scheduler"
],
"updated_ts": "1611638102118440",
"url": "https://ci.chromium.org/b/8857072047190795600",
"utcnow_ts": "1611638102490467"
}
}
[05:15:02.502] Invocation finished in 53m31.541605945s with status SUCCEEDED