[20:43:14.251] New invocation is queued and will start shortly
[20:43:15.332] Starting the invocation (attempt 1)
[20:43:15.377] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:43:15.377] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:43:15.377] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021262584060349200",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b0620ea2d540bf7507c290e8317e04600ceba6df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021262584060349200",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b0620ea2d540bf7507c290e8317e04600ceba6df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0620ea2d540bf7507c290e8317e04600ceba6df",
"gitiles_ref:refs/heads/master"
]
}
[20:43:16.063] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1612816995510798",
"id": "8855832522074545360",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b0620ea2d540bf7507c290e8317e04600ceba6df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612816995945919",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180392",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b0620ea2d540bf7507c290e8317e04600ceba6df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0620ea2d540bf7507c290e8317e04600ceba6df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021262584060349200",
"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/8855832522074545360/+/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": "1612816995946023",
"url": "https://ci.chromium.org/b/8855832522074545360",
"utcnow_ts": "1612816996054842"
}
}
[20:43:16.063] Task URL: https://ci.chromium.org/b/8855832522074545360
[20:43:16.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:2:0) after 1m0s
[20:43:19.278] Received PubSub notification, asking Buildbucket for the build status
[20:43:19.348] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:16.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:2:0)
[20:44:16.330] Timer tick, asking Buildbucket for the build status
[20:44:16.447] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:16.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:4:0) after 1m0s
[20:45:16.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:4:0)
[20:45:16.506] Timer tick, asking Buildbucket for the build status
[20:45:16.559] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:5:0) after 1m0s
[20:46:16.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:5:0)
[20:46:16.707] Timer tick, asking Buildbucket for the build status
[20:46:16.829] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:16.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:6:0) after 1m0s
[20:47:16.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:6:0)
[20:47:16.899] Timer tick, asking Buildbucket for the build status
[20:47:17.068] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:7:0) after 1m0s
[20:48:17.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:7:0)
[20:48:17.128] Timer tick, asking Buildbucket for the build status
[20:48:17.238] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:8:0) after 1m0s
[20:49:17.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:8:0)
[20:49:17.323] Timer tick, asking Buildbucket for the build status
[20:49:18.335] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:18.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:9:0) after 1m0s
[20:50:18.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:9:0)
[20:50:18.455] Timer tick, asking Buildbucket for the build status
[20:50:18.519] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:18.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:10:0) after 1m0s
[20:51:18.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:10:0)
[20:51:18.699] Timer tick, asking Buildbucket for the build status
[20:51:18.771] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:18.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:11:0) after 1m0s
[20:52:18.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:11:0)
[20:52:18.895] Timer tick, asking Buildbucket for the build status
[20:52:18.960] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:12:0) after 1m0s
[20:53:19.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:12:0)
[20:53:19.014] Timer tick, asking Buildbucket for the build status
[20:53:19.441] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:19.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:13:0) after 1m0s
[20:54:19.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:13:0)
[20:54:19.493] Timer tick, asking Buildbucket for the build status
[20:54:19.634] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:19.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:14:0) after 1m0s
[20:55:19.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:14:0)
[20:55:19.711] Timer tick, asking Buildbucket for the build status
[20:55:19.780] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:19.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:15:0) after 1m0s
[20:56:19.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:15:0)
[20:56:19.827] Timer tick, asking Buildbucket for the build status
[20:56:20.036] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:20.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:16:0) after 1m0s
[20:57:20.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:16:0)
[20:57:20.065] Timer tick, asking Buildbucket for the build status
[20:57:20.572] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:20.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:17:0) after 1m0s
[20:58:20.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:17:0)
[20:58:20.607] Timer tick, asking Buildbucket for the build status
[20:58:20.818] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:20.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:18:0) after 1m0s
[20:59:20.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:18:0)
[20:59:20.842] Timer tick, asking Buildbucket for the build status
[20:59:21.197] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:21.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:19:0) after 1m0s
[21:00:21.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:19:0)
[21:00:21.237] Timer tick, asking Buildbucket for the build status
[21:00:21.298] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:21.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:20:0) after 1m0s
[21:01:21.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:20:0)
[21:01:21.363] Timer tick, asking Buildbucket for the build status
[21:01:21.452] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:21.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:21:0) after 1m0s
[21:02:21.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:21:0)
[21:02:21.471] Timer tick, asking Buildbucket for the build status
[21:02:21.623] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:21.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:22:0) after 1m0s
[21:03:21.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:22:0)
[21:03:21.700] Timer tick, asking Buildbucket for the build status
[21:03:21.810] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:21.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:23:0) after 1m0s
[21:04:21.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:23:0)
[21:04:21.845] Timer tick, asking Buildbucket for the build status
[21:04:21.927] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:24:0) after 1m0s
[21:05:21.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:24:0)
[21:05:21.984] Timer tick, asking Buildbucket for the build status
[21:05:22.262] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:22.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:25:0) after 1m0s
[21:06:22.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:25:0)
[21:06:22.273] Timer tick, asking Buildbucket for the build status
[21:06:22.345] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:22.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:26:0) after 1m0s
[21:07:22.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:26:0)
[21:07:22.381] Timer tick, asking Buildbucket for the build status
[21:07:22.487] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:22.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:27:0) after 1m0s
[21:08:22.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:27:0)
[21:08:22.547] Timer tick, asking Buildbucket for the build status
[21:08:22.673] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:22.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:28:0) after 1m0s
[21:09:22.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:28:0)
[21:09:22.736] Timer tick, asking Buildbucket for the build status
[21:09:22.812] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:22.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:29:0) after 1m0s
[21:10:22.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:29:0)
[21:10:22.898] Timer tick, asking Buildbucket for the build status
[21:10:22.984] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:22.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:30:0) after 1m0s
[21:11:23.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:30:0)
[21:11:23.110] Timer tick, asking Buildbucket for the build status
[21:11:23.182] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:23.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:31:0) after 1m0s
[21:12:23.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:31:0)
[21:12:23.189] Timer tick, asking Buildbucket for the build status
[21:12:23.266] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:23.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:32:0) after 1m0s
[21:13:23.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:32:0)
[21:13:23.405] Timer tick, asking Buildbucket for the build status
[21:13:23.500] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:23.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:33:0) after 1m0s
[21:14:23.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:33:0)
[21:14:23.561] Timer tick, asking Buildbucket for the build status
[21:14:23.628] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:23.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:34:0) after 1m0s
[21:15:23.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:34:0)
[21:15:23.844] Timer tick, asking Buildbucket for the build status
[21:15:23.912] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:23.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:35:0) after 1m0s
[21:16:24.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:35:0)
[21:16:24.109] Timer tick, asking Buildbucket for the build status
[21:16:24.422] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:24.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:36:0) after 1m0s
[21:17:24.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:36:0)
[21:17:24.448] Timer tick, asking Buildbucket for the build status
[21:17:24.505] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:24.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:37:0) after 1m0s
[21:18:24.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:37:0)
[21:18:24.496] Timer tick, asking Buildbucket for the build status
[21:18:25.072] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:25.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:38:0) after 1m0s
[21:19:25.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:38:0)
[21:19:25.147] Timer tick, asking Buildbucket for the build status
[21:19:25.345] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:25.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:39:0) after 1m0s
[21:20:25.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:39:0)
[21:20:25.390] Timer tick, asking Buildbucket for the build status
[21:20:25.448] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:40:0) after 1m0s
[21:21:25.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:40:0)
[21:21:25.600] Timer tick, asking Buildbucket for the build status
[21:21:25.670] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:25.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:41:0) after 1m0s
[21:22:25.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:41:0)
[21:22:25.697] Timer tick, asking Buildbucket for the build status
[21:22:25.745] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:25.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:42:0) after 1m0s
[21:23:25.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:42:0)
[21:23:25.763] Timer tick, asking Buildbucket for the build status
[21:23:25.865] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:25.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:43:0) after 1m0s
[21:24:26.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:43:0)
[21:24:26.132] Timer tick, asking Buildbucket for the build status
[21:24:26.192] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:26.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:44:0) after 1m0s
[21:25:26.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:44:0)
[21:25:26.273] Timer tick, asking Buildbucket for the build status
[21:25:26.479] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:26.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:45:0) after 1m0s
[21:26:26.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:45:0)
[21:26:26.534] Timer tick, asking Buildbucket for the build status
[21:26:27.011] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:27.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:46:0) after 1m0s
[21:27:27.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:46:0)
[21:27:27.113] Timer tick, asking Buildbucket for the build status
[21:27:27.220] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:27.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:47:0) after 1m0s
[21:28:27.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:47:0)
[21:28:27.366] Timer tick, asking Buildbucket for the build status
[21:28:27.522] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:27.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:48:0) after 1m0s
[21:29:27.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:48:0)
[21:29:27.584] Timer tick, asking Buildbucket for the build status
[21:29:27.645] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:49:0) after 1m0s
[21:30:27.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:49:0)
[21:30:27.778] Timer tick, asking Buildbucket for the build status
[21:30:27.831] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:50:0) after 1m0s
[21:31:27.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:50:0)
[21:31:27.857] Timer tick, asking Buildbucket for the build status
[21:31:27.924] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:27.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:51:0) after 1m0s
[21:32:27.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:51:0)
[21:32:27.958] Timer tick, asking Buildbucket for the build status
[21:32:28.239] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:28.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:52:0) after 1m0s
[21:33:28.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:52:0)
[21:33:28.284] Timer tick, asking Buildbucket for the build status
[21:33:28.404] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:28.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:53:0) after 1m0s
[21:34:28.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:53:0)
[21:34:28.542] Timer tick, asking Buildbucket for the build status
[21:34:28.726] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:28.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:54:0) after 1m0s
[21:35:28.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:54:0)
[21:35:28.888] Timer tick, asking Buildbucket for the build status
[21:35:28.963] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:28.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:55:0) after 1m0s
[21:36:29.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:55:0)
[21:36:29.025] Timer tick, asking Buildbucket for the build status
[21:36:29.135] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:29.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:56:0) after 1m0s
[21:37:29.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:56:0)
[21:37:29.206] Timer tick, asking Buildbucket for the build status
[21:37:29.460] Build 8855832522074545360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:29.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021262584060349200:57:0) after 1m0s
[21:37:33.062] Received PubSub notification, asking Buildbucket for the build status
[21:37:33.318] Build 8855832522074545360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:37:33.318] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1612820251932593",
"created_by": "project:chromium",
"created_ts": "1612816995510798",
"id": "8855832522074545360",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b0620ea2d540bf7507c290e8317e04600ceba6df\"}}",
"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\": \"b0620ea2d540bf7507c290e8317e04600ceba6df\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180392, \"got_angle_revision\": \"9d5fd2e460ae55d413cd742c17f341f4676ed9cb\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"b0620ea2d540bf7507c290e8317e04600ceba6df\", \"got_revision_cp\": \"refs/heads/master@{#851870}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"9d35d544ce966098fdcb36107835d57a4dc1f32d\", \"got_v8_revision\": \"1a1aa77644c24808d3356293ac0602cd23506b57\", \"got_v8_revision_cp\": \"refs/heads/9.0.142@{#1}\", \"got_webrtc_revision\": \"b586d82a9434194146776337abe2ea55da0d45f8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33189}\", \"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\": \"b0620ea2d540bf7507c290e8317e04600ceba6df\", \"swarm_hashes_refs/heads/master(at){#851870}_without_patch\": {\"absl_hardening_tests\": \"77bb578de92ba656ff8027375666b6d59c3797a5\", \"accessibility_unittests\": \"105cb1e57464b838a25e0eb303a76dcafa680799\", \"angle_unittests\": \"2c35ec63aef4b312ae1d7a67e91f782668b05672\", \"app_shell_unittests\": \"fba68a099df0a7290f95a9a07cb4be2de1d84349\", \"aura_unittests\": \"3002a2067678cf5409c8ed19f25e99b0a0c88eac\", \"base_unittests\": \"0df96535e78bb09abfcf2ba51bf2b8d5c8c34059\", \"base_util_unittests\": \"c31f3f510cc5241c6bfa6cceed38ba55673db8f9\", \"blink_common_unittests\": \"d1d0ccdd088d897c3593991ad162832d85b2d171\", \"blink_fuzzer_unittests\": \"a0bb505f6cf3fdd55912811603bfb3baaddccc0d\", \"blink_heap_unittests\": \"3b3ab736d3b4e72b61d848ad1142cea88f2004fc\", \"blink_platform_unittests\": \"7a20d0debcfbf28c562b3a3ce299eafde8516beb\", \"blink_python_tests\": \"9c4f577f550a6e5a319e90fa5c3c8cd0993e2310\", \"blink_unittests\": \"c2dda64e78ef782868f9a8a1a1394f16a7cefd02\", \"blink_web_tests\": \"0f51d778c2d750059b0afe6bbb6b110c45a6c2af\", \"boringssl_crypto_tests\": \"c257291125132faddca6ce56a9cf77ad7a477416\", \"boringssl_ssl_tests\": \"bc18ba2f6a13da429a2112ebbcf646dbe520e69a\", \"browser_tests\": \"be4afc02879299e66b1210327f4383ad2005a61d\", \"capture_unittests\": \"0408728051041ce7472a1b781cb514a08016012d\", \"cast_unittests\": \"1be099ed73d752b2aa9c394461f199f82b5ea04a\", \"cc_unittests\": \"71f888493510894f63931f34d61cfd41343c29c7\", \"chrome_app_unittests\": \"c4376deecc6bc67ab439a14f584ca92ede9db2f4\", \"chromedriver_unittests\": \"77a645bb845d5584a0f6ce4defc89bad8dbc6406\", \"components_browsertests\": \"a220cf3c3973968c74a41b1a5762133f53d126d4\", \"components_unittests\": \"27903338e028897440d703a959c8ddc133a663f7\", \"compositor_unittests\": \"eeb1752ff0e3ad914111cec02630bc05f6c0abef\", \"content_browsertests\": \"f3848dafcd1e8c6c8176347b37739c94808e8631\", \"content_shell_crash_test\": \"110ab72fa612b8f8e09ae6e46b87cb88170389f9\", \"content_unittests\": \"cbb10d0a15a37dc2b9af2e788345592fba0a99a2\", \"crashpad_tests\": \"7d0145b634f028f39e03a1fd1bc39fb9b40a2487\", \"cronet_tests\": \"b75da28e3c7ed0398f36989c06c8d6005b9614ff\", \"cronet_unittests\": \"785d50fe342772b6e4f3ed494c328d3d647b7066\", \"crypto_unittests\": \"049aec5450fd14bc41f92c2a6f895d4e4f729e1e\", \"dbus_unittests\": \"2e79ba0e6d591784a534bad8386e79fd9eb229ab\", \"device_unittests\": \"f1190098271fd5503620b327cfe98bc1f7191f94\", \"display_unittests\": \"3e7e2889f29bb193b02f2c52fd0937b8b4aaf37b\", \"events_unittests\": \"6a09212c5926adfecb70f0de9e1b868ab4e5f27d\", \"extensions_browsertests\": \"dce14b614ed3346da521ac2d41d8423486cae2ab\", \"extensions_unittests\": \"b7d5997f97cfcee66406fccd58f134e1debca37a\", \"filesystem_service_unittests\": \"0878aea50ead9b6101271d9358ae0a0b7ca00903\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"a346883b645c992453d441d81363ebd8b6b51683\", \"gfx_unittests\": \"aebac95cc170157e5f574bf659db91510bfa467b\", \"gin_unittests\": \"71459254142657bd1cae0d21fbb6b3dfa92a30fc\", \"google_apis_unittests\": \"8d8dccfbea76d81131af2d3c6be4ee67bd281fc2\", \"gpu_unittests\": \"5eaf70fc03518ea6353f2c545c59aefccacc65e4\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"6fd5d2d4f52eb334e5201e0750a0838d5baa9d0a\", \"headless_browsertests\": \"7108b7027fe37a59c1acf5a61a1b8bf24ca4d70d\", \"headless_unittests\": \"dea4d52ae4d2e08b64381a30f34c391c60f2f8dc\", \"interactive_ui_tests\": \"6cdb30988cab2e467735d6c1434a4c262327d0e0\", \"ipc_tests\": \"c5418d886e985091ca9d0ed813a95760560ab45a\", \"jingle_unittests\": \"dbbfd8bbcc910eeba9ecc9965e367d9022a1a9d0\", \"latency_unittests\": \"3597fcea48286bd94dfd5da6ece881354f7db457\", \"libjingle_xmpp_unittests\": \"ea9414b2de8812627cbdeabb2d567ac69c604389\", \"liburlpattern_unittests\": \"b7c0746a8af329a34aa8431810774242178c6f98\", \"media_blink_unittests\": \"0d3247e6d184de74f122677fe4c18dc075e318c4\", \"media_unittests\": \"a1ab5f97423f768aa318f36e1c65e1c86e85a3f8\", \"message_center_unittests\": \"2a0bea22a573af14a77295c43800bd8b61f7d07b\", \"metrics_python_tests\": \"fab1394e9d57724043323f687aa1dea6acb44ae1\", \"midi_unittests\": \"015784b1eade2504e9a4cb25dff380f0aff704ec\", \"mojo_core_unittests\": \"acb7ed309b1ecdd898fc456af522c9bec91fb610\", \"mojo_unittests\": \"f844f312f93344c984ae67772c9d7620ef0bc33f\", \"nacl_helper_nonsfi_unittests\": \"55bc407a9f53b0b8882ee7b58b6b4dd2003a9171\", \"nacl_loader_unittests\": \"b6cb18a8a978c295eb83e04f8ed67800e9711809\", \"native_theme_unittests\": \"924fc87879c4269236b5d207443cbb04c749b130\", \"net_unittests\": \"7c2f5b1a412dc2b2b62b896484d842d2230bbabf\", \"openscreen_unittests\": \"818ab8534e938d20d4639f40cfd991da1a9eace9\", \"pdf_unittests\": \"75dbc87ace78cc44f7ac797f18165d2ebe6ae677\", \"perfetto_unittests\": \"81b0a5b24de78299c48d5d1dc60601c76a204572\", \"ppapi_unittests\": \"9ebf16a73459919d4fe1ef05cefc5291128c2bfa\", \"printing_unittests\": \"e677369210f91fcaf3e2d135efa2a48a265c7b38\", \"remoting_unittests\": \"3847460e86a122f10c101a00619702429a17bfe0\", \"sandbox_linux_unittests\": \"4ba10e8558a4545e5bacad105550bca16c42befd\", \"service_manager_unittests\": \"2fe4da2abe7b17e9e652fdc0913c264c89c3aa9a\", \"services_unittests\": \"3aac53e1d6608d29a4c7a8f88508c1d68e3a93eb\", \"shell_dialogs_unittests\": \"7fd09802e6d17d51f88ac8b63058735c6881da11\", \"skia_unittests\": \"c45ff0a1bea3bdfd4a19514f139caef122ec3e19\", \"snapshot_unittests\": \"9b8503a8f08d9e31cee378fd76646f3663207493\", \"sql_unittests\": \"c61e5b392fabe62acddbff174333f377539a5315\", \"storage_unittests\": \"58fc4bfbde544987dcd23f15688e8cb3cae0239a\", \"sync_integration_tests\": \"e924ac1487e89e9ec755759ec0b21c0fb5b123b2\", \"telemetry_gpu_unittests\": \"32db454158ce2d42880d59e54d62dedf538d55d6\", \"telemetry_perf_unittests\": \"654bb8e017f4977a93bb29a9b29da7ebdd64f86c\", \"telemetry_unittests\": \"12d32492f18d325925c4e655a9369b72fd432544\", \"traffic_annotation_auditor_unittests\": \"0f9bab3cb568b6e0d1ae01b2971d15aaf8059ca8\", \"ui_base_unittests\": \"114193bd452344ce7700c4eca93d4b0a940a16f1\", \"ui_touch_selection_unittests\": \"0e70fdb56142e00d3ee4aa7353291d184dc75444\", \"unit_tests\": \"9ebab6a0b51b6e256da03a197991b7a99174823a\", \"url_unittests\": \"98260e9f6c6873241a3a57e0e6c2ba6f69d78e06\", \"views_perftests\": \"6f52697b2fe72efbb02edae386d87470fdd34edb\", \"views_unittests\": \"f94fce0885ffad7d7084a5186a720a7eee886c21\", \"viz_unittests\": \"6c2d6c58b2372814db68988d030ee987152b93a3\", \"vr_common_unittests\": \"90a42fbd647227dadd685f2dc3ab6f3ffad5cec3\", \"vr_pixeltests\": \"5f11d730b856d54679ba952e8b413f76becc7035\", \"webdriver_wpt_tests\": \"d34c7a276b833e545e91141d3f187e3fc1a17a17\", \"weblayer_browsertests\": \"2dc76824ff07dc167d1d757eaa764655813343ee\", \"weblayer_unittests\": \"1a0513610cd020ec620b2d1fcd707ee0c8d53b61\", \"wm_unittests\": \"d8a0a6110048c86e67f4df2543ba5c6ef88f1652\", \"wtf_unittests\": \"1c1032ed341541049e96740734782627786c7e11\", \"x11_unittests\": \"ee87db9a238ac35b57b073512d614dcd67d5b8a1\", \"xr_browser_tests\": \"3c16960ecd9fcb2ddff991ff56cc39ed807ac2af\", \"zlib_unittests\": \"13beda48d1bdde1231c6e78d440cefe18f014175\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_863d9d6073a39cfd51a17e8c0be606c54177e8c90f2c9a7c0e7333e92d562081_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-68-2v8w\"], \"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\": [\"5681-01e7fd1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612816998564609",
"status": "COMPLETED",
"status_changed_ts": "1612820252821463",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180392",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b0620ea2d540bf7507c290e8317e04600ceba6df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0620ea2d540bf7507c290e8317e04600ceba6df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021262584060349200",
"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/8855832522074545360/+/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:519c33dfcfa9e710",
"user_agent:luci-scheduler"
],
"updated_ts": "1612820252826280",
"url": "https://ci.chromium.org/b/8855832522074545360",
"utcnow_ts": "1612820253304829"
}
}
[21:37:33.318] Invocation finished in 54m19.085774369s with status SUCCEEDED