[03:12:29.909] New invocation is queued and will start shortly
[03:12:31.474] Starting the invocation (attempt 1)
[03:12:31.514] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:31.514] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:31.514] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022234660503322720",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a31994e3da77c609e509528b246aac903f1387ae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022234660503322720",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a31994e3da77c609e509528b246aac903f1387ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a31994e3da77c609e509528b246aac903f1387ae",
"gitiles_ref:refs/heads/master"
]
}
[03:12:32.796] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611889951661791",
"id": "8856804598005463504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a31994e3da77c609e509528b246aac903f1387ae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611889952307981",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180083",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a31994e3da77c609e509528b246aac903f1387ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a31994e3da77c609e509528b246aac903f1387ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022234660503322720",
"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/8856804598005463504/+/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": "1611889952308097",
"url": "https://ci.chromium.org/b/8856804598005463504",
"utcnow_ts": "1611889952787243"
}
}
[03:12:32.796] Task URL: https://ci.chromium.org/b/8856804598005463504
[03:12:32.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:2:0) after 1m0s
[03:12:35.457] Received PubSub notification, asking Buildbucket for the build status
[03:12:35.525] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:32.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:2:0)
[03:13:32.932] Timer tick, asking Buildbucket for the build status
[03:13:33.216] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:33.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:4:0) after 1m0s
[03:14:33.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:4:0)
[03:14:33.354] Timer tick, asking Buildbucket for the build status
[03:14:33.659] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:33.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:5:0) after 1m0s
[03:15:33.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:5:0)
[03:15:33.707] Timer tick, asking Buildbucket for the build status
[03:15:33.768] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:33.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:6:0) after 1m0s
[03:16:33.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:6:0)
[03:16:33.737] Timer tick, asking Buildbucket for the build status
[03:16:33.834] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:33.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:7:0) after 1m0s
[03:17:33.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:7:0)
[03:17:33.868] Timer tick, asking Buildbucket for the build status
[03:17:34.176] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:34.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:8:0) after 1m0s
[03:18:34.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:8:0)
[03:18:34.168] Timer tick, asking Buildbucket for the build status
[03:18:34.278] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:34.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:9:0) after 1m0s
[03:19:34.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:9:0)
[03:19:34.352] Timer tick, asking Buildbucket for the build status
[03:19:34.408] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:34.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:10:0) after 1m0s
[03:20:34.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:10:0)
[03:20:34.443] Timer tick, asking Buildbucket for the build status
[03:20:34.616] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:34.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:11:0) after 1m0s
[03:21:34.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:11:0)
[03:21:34.632] Timer tick, asking Buildbucket for the build status
[03:21:34.830] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:34.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:12:0) after 1m0s
[03:22:34.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:12:0)
[03:22:34.904] Timer tick, asking Buildbucket for the build status
[03:22:35.082] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:35.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:13:0) after 1m0s
[03:23:35.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:13:0)
[03:23:35.102] Timer tick, asking Buildbucket for the build status
[03:23:35.791] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:35.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:14:0) after 1m0s
[03:24:35.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:14:0)
[03:24:35.818] Timer tick, asking Buildbucket for the build status
[03:24:35.896] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:35.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:15:0) after 1m0s
[03:25:35.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:15:0)
[03:25:35.913] Timer tick, asking Buildbucket for the build status
[03:25:36.121] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:36.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:16:0) after 1m0s
[03:26:36.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:16:0)
[03:26:36.174] Timer tick, asking Buildbucket for the build status
[03:26:36.259] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:36.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:17:0) after 1m0s
[03:27:36.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:17:0)
[03:27:36.269] Timer tick, asking Buildbucket for the build status
[03:27:36.987] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:18:0) after 1m0s
[03:28:37.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:18:0)
[03:28:37.032] Timer tick, asking Buildbucket for the build status
[03:28:37.326] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:37.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:19:0) after 1m0s
[03:29:37.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:19:0)
[03:29:37.374] Timer tick, asking Buildbucket for the build status
[03:29:37.482] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:37.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:20:0) after 1m0s
[03:30:37.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:20:0)
[03:30:37.546] Timer tick, asking Buildbucket for the build status
[03:30:37.647] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:37.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:21:0) after 1m0s
[03:31:37.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:21:0)
[03:31:37.672] Timer tick, asking Buildbucket for the build status
[03:31:37.919] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:37.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:22:0) after 1m0s
[03:32:37.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:22:0)
[03:32:37.999] Timer tick, asking Buildbucket for the build status
[03:32:39.165] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:39.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:23:0) after 1m0s
[03:33:39.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:23:0)
[03:33:39.293] Timer tick, asking Buildbucket for the build status
[03:33:39.399] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:39.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:24:0) after 1m0s
[03:34:39.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:24:0)
[03:34:39.443] Timer tick, asking Buildbucket for the build status
[03:34:39.506] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:39.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:25:0) after 1m0s
[03:35:39.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:25:0)
[03:35:39.641] Timer tick, asking Buildbucket for the build status
[03:35:39.914] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:39.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:26:0) after 1m0s
[03:36:39.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:26:0)
[03:36:39.977] Timer tick, asking Buildbucket for the build status
[03:36:40.067] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:40.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:27:0) after 1m0s
[03:37:40.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:27:0)
[03:37:40.122] Timer tick, asking Buildbucket for the build status
[03:37:40.225] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:40.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:28:0) after 1m0s
[03:38:40.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:28:0)
[03:38:40.293] Timer tick, asking Buildbucket for the build status
[03:38:40.362] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:40.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:29:0) after 1m0s
[03:39:40.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:29:0)
[03:39:40.407] Timer tick, asking Buildbucket for the build status
[03:39:40.528] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:40.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:30:0) after 1m0s
[03:40:40.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:30:0)
[03:40:40.512] Timer tick, asking Buildbucket for the build status
[03:40:40.738] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:40.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:31:0) after 1m0s
[03:41:40.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:31:0)
[03:41:40.871] Timer tick, asking Buildbucket for the build status
[03:41:41.019] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:32:0) after 1m0s
[03:42:41.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:32:0)
[03:42:41.115] Timer tick, asking Buildbucket for the build status
[03:42:41.225] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:41.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:33:0) after 1m0s
[03:43:41.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:33:0)
[03:43:41.199] Timer tick, asking Buildbucket for the build status
[03:43:41.309] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:41.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:34:0) after 1m0s
[03:44:41.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:34:0)
[03:44:41.407] Timer tick, asking Buildbucket for the build status
[03:44:41.513] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:41.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:35:0) after 1m0s
[03:45:41.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:35:0)
[03:45:41.541] Timer tick, asking Buildbucket for the build status
[03:45:41.600] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:41.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:36:0) after 1m0s
[03:46:41.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:36:0)
[03:46:41.630] Timer tick, asking Buildbucket for the build status
[03:46:41.689] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:41.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:37:0) after 1m0s
[03:47:41.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:37:0)
[03:47:41.748] Timer tick, asking Buildbucket for the build status
[03:47:42.064] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:42.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:38:0) after 1m0s
[03:48:42.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:38:0)
[03:48:42.113] Timer tick, asking Buildbucket for the build status
[03:48:42.172] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:42.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:39:0) after 1m0s
[03:49:42.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:39:0)
[03:49:42.262] Timer tick, asking Buildbucket for the build status
[03:49:42.358] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:42.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:40:0) after 1m0s
[03:50:42.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:40:0)
[03:50:42.392] Timer tick, asking Buildbucket for the build status
[03:50:42.711] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:42.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:41:0) after 1m0s
[03:51:42.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:41:0)
[03:51:42.740] Timer tick, asking Buildbucket for the build status
[03:51:42.943] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:42.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:42:0) after 1m0s
[03:52:42.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:42:0)
[03:52:42.963] Timer tick, asking Buildbucket for the build status
[03:52:43.124] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:43.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:43:0) after 1m0s
[03:53:43.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:43:0)
[03:53:43.149] Timer tick, asking Buildbucket for the build status
[03:53:43.215] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:43.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:44:0) after 1m0s
[03:54:43.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:44:0)
[03:54:43.283] Timer tick, asking Buildbucket for the build status
[03:54:43.443] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:43.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:45:0) after 1m0s
[03:55:43.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:45:0)
[03:55:43.538] Timer tick, asking Buildbucket for the build status
[03:55:43.636] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:46:0) after 1m0s
[03:56:43.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:46:0)
[03:56:43.680] Timer tick, asking Buildbucket for the build status
[03:56:43.771] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:43.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:47:0) after 1m0s
[03:57:43.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:47:0)
[03:57:43.863] Timer tick, asking Buildbucket for the build status
[03:57:44.307] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:44.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:48:0) after 1m0s
[03:58:44.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:48:0)
[03:58:44.329] Timer tick, asking Buildbucket for the build status
[03:58:44.601] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:49:0) after 1m0s
[03:59:44.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:49:0)
[03:59:44.617] Timer tick, asking Buildbucket for the build status
[03:59:44.903] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:44.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:50:0) after 1m0s
[04:00:44.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:50:0)
[04:00:44.991] Timer tick, asking Buildbucket for the build status
[04:00:45.271] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:45.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:51:0) after 1m0s
[04:01:45.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:51:0)
[04:01:45.270] Timer tick, asking Buildbucket for the build status
[04:01:45.609] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:45.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:52:0) after 1m0s
[04:02:45.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:52:0)
[04:02:45.654] Timer tick, asking Buildbucket for the build status
[04:02:45.959] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:45.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:53:0) after 1m0s
[04:03:46.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:53:0)
[04:03:46.038] Timer tick, asking Buildbucket for the build status
[04:03:46.267] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:46.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:54:0) after 1m0s
[04:04:46.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:54:0)
[04:04:46.295] Timer tick, asking Buildbucket for the build status
[04:04:46.366] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:46.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:55:0) after 1m0s
[04:05:46.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:55:0)
[04:05:46.423] Timer tick, asking Buildbucket for the build status
[04:05:46.483] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:46.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:56:0) after 1m0s
[04:06:46.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:56:0)
[04:06:46.529] Timer tick, asking Buildbucket for the build status
[04:06:46.592] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:46.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:57:0) after 1m0s
[04:07:46.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:57:0)
[04:07:46.706] Timer tick, asking Buildbucket for the build status
[04:07:46.814] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:46.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:58:0) after 1m0s
[04:08:46.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:58:0)
[04:08:46.954] Timer tick, asking Buildbucket for the build status
[04:08:47.613] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:47.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:59:0) after 1m0s
[04:09:47.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:59:0)
[04:09:47.631] Timer tick, asking Buildbucket for the build status
[04:09:47.706] Build 8856804598005463504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:47.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022234660503322720:60:0) after 1m0s
[04:10:41.227] Received PubSub notification, asking Buildbucket for the build status
[04:10:41.415] Build 8856804598005463504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:10:41.415] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611893440530785",
"created_by": "project:chromium",
"created_ts": "1611889951661791",
"id": "8856804598005463504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a31994e3da77c609e509528b246aac903f1387ae\"}}",
"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\": \"a31994e3da77c609e509528b246aac903f1387ae\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-72-9inl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180083, \"got_angle_revision\": \"a685db2e9745b615987b1b514dc23cc2fafff7bd\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"a31994e3da77c609e509528b246aac903f1387ae\", \"got_revision_cp\": \"refs/heads/master@{#848381}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"a31994e3da77c609e509528b246aac903f1387ae\", \"swarm_hashes_refs/heads/master(at){#848381}_without_patch\": {\"absl_hardening_tests\": \"9537a88b7915508873f36c9c59a4c1866a75ae53\", \"accessibility_unittests\": \"bf39a3c4f315597f464160c18093457befe000ec\", \"angle_unittests\": \"b4b81e2c301fc3e6f9531b4ed2820ffd6be3d550\", \"app_shell_unittests\": \"709f6d5dcf32e7ed9b87f3f82b39909f1613202c\", \"aura_unittests\": \"2cb8e4ffa9829118a51d231814fa4d50680af16b\", \"base_unittests\": \"d7de1c85ad1271c435481d42bec6fadcd982e4d0\", \"base_util_unittests\": \"2911fcea3ca26cf08ce58e38ec591341eeb43f80\", \"blink_common_unittests\": \"968efcf517a8ceef2a9349b6bedf38c440750fdc\", \"blink_fuzzer_unittests\": \"221760ae2e6f6fe4b329552bff94df8085b9fd6c\", \"blink_heap_unittests\": \"a6721d35f0a3c8e584535b819c57520ee095d945\", \"blink_platform_unittests\": \"8dde3fc58a579a502fc1784730e926edbf6dd777\", \"blink_python_tests\": \"f218a47e696375c8a4076a6cfe118193d5a0a36f\", \"blink_unittests\": \"044b8f9bcb419e8ca6d7f93bc23ce82ab59fb722\", \"blink_web_tests\": \"a05c53089ed21831b257d276cde5f16b7d03fa00\", \"boringssl_crypto_tests\": \"03d86580fead64398d62dfda13739f44c72cb154\", \"boringssl_ssl_tests\": \"9e3238c5fe764864c95cc7e89888be279e3f704a\", \"browser_tests\": \"7a882d15e6e0aff24c4e4c17d91da8a65255bbea\", \"capture_unittests\": \"57bf902ae0470bb41a0866dc3489539cc70abe34\", \"cast_unittests\": \"c9196dc9a9615f763224cbeb905004ac092aa552\", \"cc_unittests\": \"80f7dbae827f585bbf532f14dd6574351f2fed2c\", \"chrome_app_unittests\": \"742e42236342357ffc2f1530fc6639737c233968\", \"chromedriver_unittests\": \"1ccc68fc9a9a678746b67113ad0fb3b12b415955\", \"components_browsertests\": \"fe5d542e3b5adeda3f86273054beb46fa53816ca\", \"components_unittests\": \"a8199472ee84b324856a2b57eb58f8325717a95b\", \"compositor_unittests\": \"1167f89e8f8907316587b655ece5dabf37e60058\", \"content_browsertests\": \"6a5b40372d95adf7de2833c5f56f9afe31c6d472\", \"content_shell_crash_test\": \"aacc35f41ef05a02cfb73ba53434fdf453573d5c\", \"content_unittests\": \"34365149d9987d43c42a3b40a8b87129588327a0\", \"crashpad_tests\": \"f22d3aab0815165c84623a3d4b390eebed6ba893\", \"cronet_tests\": \"a8b6cbc535083f598589b43cdb2dcddda72cd9a4\", \"cronet_unittests\": \"7a0916402487ae10dec109834d1ad8a7acf2733a\", \"crypto_unittests\": \"5af6ea183abf07b611c3160bef3b434007e02b45\", \"dbus_unittests\": \"4af4d725c090719274e71c3e651b80e8d1ffa99f\", \"device_unittests\": \"f2e13c006c2aa28ea15da1aac1716e1f08eb982c\", \"display_unittests\": \"bba9888aff651c71d21201b0c22860705d26406e\", \"events_unittests\": \"697f55cff1ae20c8e8cb8b6be17378c896feb982\", \"extensions_browsertests\": \"1aa62588ee6ffc13e3fce50c4660f306ca1374de\", \"extensions_unittests\": \"2976ad118580dce96de81b90896ef55c185f07a5\", \"filesystem_service_unittests\": \"4b5f3794ce7b57fb14a3f44d4b5e6c447338dbaa\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"5023aa5a80c539a22b77adbff933f421313c7156\", \"gfx_unittests\": \"d16cccfde4df90713de55ec55d5f96b39224bdf0\", \"gin_unittests\": \"ee8ce164e5fd9d11aa2fb1d1dbb018587be11d96\", \"google_apis_unittests\": \"d00d307c58e70ad7beee0ab7e62cb62318dd367a\", \"gpu_unittests\": \"b65323599fdde0b468adf26f9c307554405e9771\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"4e379c85e4667181062c7dc3f84420e6faa40bc6\", \"headless_browsertests\": \"e7e74d53beb9ceb395f0e0f8575976829ac601ff\", \"headless_unittests\": \"914076e344a3d2cc694397482440d4514c9de06e\", \"interactive_ui_tests\": \"f9fb0d8a0c21b00d11f2b5962b1106563b65a2f8\", \"ipc_tests\": \"1b17eea9ce4484c73dd758d8fe7af8a7c60eaa95\", \"jingle_unittests\": \"619b96ad59e5d3cd73e9358e4aa73b7ff157acd3\", \"latency_unittests\": \"c91424551f0b7be9b04b1bdd25aceb0562eb8df5\", \"libjingle_xmpp_unittests\": \"b929224ffe402a9f3b66ebb39ef6c419d1e8a14c\", \"liburlpattern_unittests\": \"fb50d59f480ab3d5988d8a7e0bcf6656bfcf422a\", \"media_blink_unittests\": \"8bab0066d69cd74b9ae62722fdc7ac3f7aa004a0\", \"media_unittests\": \"04962f57c37b4e11ed010a712ac82a913fb961a1\", \"message_center_unittests\": \"6cd6d27fab2dd58087096d578fbd69d67ad3769e\", \"metrics_python_tests\": \"031981b287aff1d32853c64ff5cd7f5488f6bf94\", \"midi_unittests\": \"a5e44a0b27305813ad5de4ad13585f34e553d6d8\", \"mojo_core_unittests\": \"c7bbe9d62d022c810b968699a8ca58076e561a48\", \"mojo_unittests\": \"62eac5b47c9d365619b6f19c137fe489349db2e3\", \"nacl_helper_nonsfi_unittests\": \"799d61310acb5281d89f7238b87c48c0f4c9508e\", \"nacl_loader_unittests\": \"e10c2373b98e5007f588d943f872efdd83fe64aa\", \"native_theme_unittests\": \"df96f0bb33051371947ac646a88974e4aeb2a88a\", \"net_unittests\": \"1807e3f61861364bc11de2e42eacaf0ee5b33a36\", \"openscreen_unittests\": \"aafe3bdb6ed01c0563e06e5186a1360e360b9bc9\", \"pdf_unittests\": \"18f94f2dc07954c6f0cd17a64f597b36c7c7406a\", \"perfetto_unittests\": \"2d15f390882fca65735acab2e6f02c798e0e99de\", \"ppapi_unittests\": \"fa59bdde2f0185ce5ed40532105ede85977d50ab\", \"printing_unittests\": \"767f654950df9f3ae7b2286c95c6449049366af6\", \"remoting_unittests\": \"4fd74ea420fbd6abd22b246e5980956f88c0385b\", \"sandbox_linux_unittests\": \"295c02ae18d2406f3989e6b7c04e5378fb5b6738\", \"service_manager_unittests\": \"d4ae204af647f8b7fd3656d8bcda678b3c1ae634\", \"services_unittests\": \"395115384e655cf12bf2df8ac840365774c36161\", \"shell_dialogs_unittests\": \"d0ea334690cc0e2bd3076bafe5250e7739883f1a\", \"skia_unittests\": \"fa5b51b333523b0644ee272eef4cb7e54404bbdc\", \"snapshot_unittests\": \"914d33bae0ec403a00583c982aef639151f52ef1\", \"sql_unittests\": \"17bce550fa196da455d0ae462590f710fe3fa96c\", \"storage_unittests\": \"0eca455aff780cfb686c8dfc0578ed241e512ba4\", \"sync_integration_tests\": \"0e47b2ba8dac1322d011be4cafc4f7ba2e9791a5\", \"telemetry_gpu_unittests\": \"86a5f044a4dbd1ebbb343452cf3dfd6fe8f56f32\", \"telemetry_perf_unittests\": \"fccd8bc3e565ef9c39b016ed1f050f320dd4fb58\", \"telemetry_unittests\": \"0bc89ced287478215f33bdfc262ed546776337b1\", \"traffic_annotation_auditor_unittests\": \"3d121e15c21c08a0de6b64ba996ca3b9e6179ef0\", \"ui_base_unittests\": \"af0e427b770e4182a0edbfc073ef7af85d54f6d9\", \"ui_touch_selection_unittests\": \"d235e4296adc8a085bf1a4f623819e511f8eac85\", \"unit_tests\": \"b648225c9f23c19e405e09c9ef209a09837f6b36\", \"url_unittests\": \"c5f6ed1fe0dffe1858f166e1a9f5d6d653aa533e\", \"views_perftests\": \"a46915b24e049be0bc6364fa96ab0a8af19b2ed7\", \"views_unittests\": \"73d6543b1a801b7cac4cf8d2d15869f7d77bab76\", \"viz_unittests\": \"21350a4ef31399da0ba598fb63fcd7472a150f0f\", \"vr_common_unittests\": \"066507621169c0966c0b27ce7118be8df965f513\", \"vr_pixeltests\": \"5ad874d00b5a6983fc39ab214be8d91b32a4d158\", \"webdriver_wpt_tests\": \"cdc30107d51b496e23cf66cbbb8c27e059bc8bdf\", \"weblayer_browsertests\": \"a90158b62a57f3f7f86e9b45076051119030c86f\", \"weblayer_unittests\": \"7586672f42d0f99499c3c026d7f25e006461ed3a\", \"wm_unittests\": \"aed103a28b129cc345c7a897e04284e757c1039b\", \"wtf_unittests\": \"33ada2173161b611a3e28dfc361dc7dd89d7c55c\", \"x11_unittests\": \"c6357aa6670207beb62698ec37f61843cb254e2e\", \"xr_browser_tests\": \"a2849f364da86575caafc01287b108d59d750279\", \"zlib_unittests\": \"63e56111245e24b0930ac2cce9f174b8969e8ac4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1565bd2e801a59db86c3cb29ff80b2e229b1f19a08963dbe4c2b49186438622b_v2\", \"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_746f25208a125120dfc7ef61e5ef35531bce9c0f7be870eb0811bf6f56bb01d6_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-72-9inl\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611889954536419",
"status": "COMPLETED",
"status_changed_ts": "1611893440948240",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180083",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a31994e3da77c609e509528b246aac903f1387ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a31994e3da77c609e509528b246aac903f1387ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022234660503322720",
"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/8856804598005463504/+/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:5164f2508febc410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611893440953041",
"url": "https://ci.chromium.org/b/8856804598005463504",
"utcnow_ts": "1611893441389094"
}
}
[04:10:41.415] Invocation finished in 58m11.520319139s with status SUCCEEDED