[20:02:58.660] New invocation is queued and will start shortly
[20:02:59.795] Starting the invocation (attempt 1)
[20:02:59.838] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:02:59.838] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:02:59.838] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022171086654195136",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022171086654195136",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"gitiles_ref:refs/heads/master"
]
}
[20:03:01.272] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611950579958630",
"id": "8856741024627826864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611950580835100",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180108",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022171086654195136",
"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/8856741024627826864/+/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": "1611950580835281",
"url": "https://ci.chromium.org/b/8856741024627826864",
"utcnow_ts": "1611950581219468"
}
}
[20:03:01.272] Task URL: https://ci.chromium.org/b/8856741024627826864
[20:03:01.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:2:0) after 1m0s
[20:03:27.999] Received PubSub notification, asking Buildbucket for the build status
[20:03:28.086] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:01.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:2:0)
[20:04:01.333] Timer tick, asking Buildbucket for the build status
[20:04:01.520] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:01.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:4:0) after 1m0s
[20:05:02.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:4:0)
[20:05:02.045] Timer tick, asking Buildbucket for the build status
[20:05:02.152] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:02.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:5:0) after 1m0s
[20:06:02.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:5:0)
[20:06:02.327] Timer tick, asking Buildbucket for the build status
[20:06:02.433] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:02.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:6:0) after 1m0s
[20:07:02.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:6:0)
[20:07:02.465] Timer tick, asking Buildbucket for the build status
[20:07:02.584] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:02.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:7:0) after 1m0s
[20:08:02.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:7:0)
[20:08:02.648] Timer tick, asking Buildbucket for the build status
[20:08:02.825] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:02.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:8:0) after 1m0s
[20:09:02.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:8:0)
[20:09:02.865] Timer tick, asking Buildbucket for the build status
[20:09:02.976] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:02.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:9:0) after 1m0s
[20:10:03.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:9:0)
[20:10:03.001] Timer tick, asking Buildbucket for the build status
[20:10:03.186] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:03.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:10:0) after 1m0s
[20:11:03.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:10:0)
[20:11:03.191] Timer tick, asking Buildbucket for the build status
[20:11:03.442] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:03.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:11:0) after 1m0s
[20:12:03.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:11:0)
[20:12:03.488] Timer tick, asking Buildbucket for the build status
[20:12:03.817] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:03.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:12:0) after 1m0s
[20:13:03.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:12:0)
[20:13:03.867] Timer tick, asking Buildbucket for the build status
[20:13:03.966] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:03.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:13:0) after 1m0s
[20:14:03.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:13:0)
[20:14:03.976] Timer tick, asking Buildbucket for the build status
[20:14:04.052] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:04.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:14:0) after 1m0s
[20:15:04.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:14:0)
[20:15:04.106] Timer tick, asking Buildbucket for the build status
[20:15:04.333] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:15:0) after 1m0s
[20:16:04.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:15:0)
[20:16:04.400] Timer tick, asking Buildbucket for the build status
[20:16:04.559] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:04.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:16:0) after 1m0s
[20:17:04.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:16:0)
[20:17:04.615] Timer tick, asking Buildbucket for the build status
[20:17:04.685] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:04.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:17:0) after 1m0s
[20:18:04.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:17:0)
[20:18:04.726] Timer tick, asking Buildbucket for the build status
[20:18:05.107] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:05.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:18:0) after 1m0s
[20:19:05.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:18:0)
[20:19:05.147] Timer tick, asking Buildbucket for the build status
[20:19:05.206] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:05.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:19:0) after 1m0s
[20:20:05.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:19:0)
[20:20:05.287] Timer tick, asking Buildbucket for the build status
[20:20:05.498] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:05.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:20:0) after 1m0s
[20:21:05.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:20:0)
[20:21:05.536] Timer tick, asking Buildbucket for the build status
[20:21:06.212] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:06.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:21:0) after 1m0s
[20:22:06.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:21:0)
[20:22:06.262] Timer tick, asking Buildbucket for the build status
[20:22:06.415] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:06.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:22:0) after 1m0s
[20:23:06.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:22:0)
[20:23:06.491] Timer tick, asking Buildbucket for the build status
[20:23:06.764] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:23:0) after 1m0s
[20:24:06.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:23:0)
[20:24:06.779] Timer tick, asking Buildbucket for the build status
[20:24:06.862] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:06.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:24:0) after 1m0s
[20:25:07.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:24:0)
[20:25:07.056] Timer tick, asking Buildbucket for the build status
[20:25:07.165] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:07.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:25:0) after 1m0s
[20:26:07.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:25:0)
[20:26:07.421] Timer tick, asking Buildbucket for the build status
[20:26:07.511] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:07.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:26:0) after 1m0s
[20:27:07.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:26:0)
[20:27:07.678] Timer tick, asking Buildbucket for the build status
[20:27:07.745] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:07.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:27:0) after 1m0s
[20:28:07.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:27:0)
[20:28:07.867] Timer tick, asking Buildbucket for the build status
[20:28:07.991] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:07.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:28:0) after 1m0s
[20:29:08.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:28:0)
[20:29:08.099] Timer tick, asking Buildbucket for the build status
[20:29:08.225] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:08.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:29:0) after 1m0s
[20:30:08.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:29:0)
[20:30:08.428] Timer tick, asking Buildbucket for the build status
[20:30:08.521] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:08.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:30:0) after 1m0s
[20:31:08.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:30:0)
[20:31:08.725] Timer tick, asking Buildbucket for the build status
[20:31:08.818] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:08.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:31:0) after 1m0s
[20:32:08.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:31:0)
[20:32:08.917] Timer tick, asking Buildbucket for the build status
[20:32:08.979] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:08.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:32:0) after 1m0s
[20:33:09.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:32:0)
[20:33:09.068] Timer tick, asking Buildbucket for the build status
[20:33:09.420] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:09.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:33:0) after 1m0s
[20:34:09.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:33:0)
[20:34:09.459] Timer tick, asking Buildbucket for the build status
[20:34:09.542] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:09.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:34:0) after 1m0s
[20:35:09.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:34:0)
[20:35:09.650] Timer tick, asking Buildbucket for the build status
[20:35:09.710] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:09.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:35:0) after 1m0s
[20:36:09.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:35:0)
[20:36:09.775] Timer tick, asking Buildbucket for the build status
[20:36:09.939] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:09.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:36:0) after 1m0s
[20:37:10.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:36:0)
[20:37:10.031] Timer tick, asking Buildbucket for the build status
[20:37:10.105] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:10.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:37:0) after 1m0s
[20:38:10.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:37:0)
[20:38:10.183] Timer tick, asking Buildbucket for the build status
[20:38:10.450] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:10.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:38:0) after 1m0s
[20:39:10.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:38:0)
[20:39:10.461] Timer tick, asking Buildbucket for the build status
[20:39:10.530] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:39:0) after 1m0s
[20:40:10.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:39:0)
[20:40:10.577] Timer tick, asking Buildbucket for the build status
[20:40:10.643] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:40:0) after 1m0s
[20:41:10.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:40:0)
[20:41:10.673] Timer tick, asking Buildbucket for the build status
[20:41:11.407] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:11.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:41:0) after 1m0s
[20:42:11.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:41:0)
[20:42:11.429] Timer tick, asking Buildbucket for the build status
[20:42:11.659] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:11.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:42:0) after 1m0s
[20:43:11.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:42:0)
[20:43:11.730] Timer tick, asking Buildbucket for the build status
[20:43:12.000] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:12.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:43:0) after 1m0s
[20:44:12.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:43:0)
[20:44:12.046] Timer tick, asking Buildbucket for the build status
[20:44:12.117] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:12.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:44:0) after 1m0s
[20:45:12.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:44:0)
[20:45:12.149] Timer tick, asking Buildbucket for the build status
[20:45:12.309] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:12.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:45:0) after 1m0s
[20:46:12.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:45:0)
[20:46:12.347] Timer tick, asking Buildbucket for the build status
[20:46:12.669] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:12.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:46:0) after 1m0s
[20:47:12.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:46:0)
[20:47:12.717] Timer tick, asking Buildbucket for the build status
[20:47:12.969] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:12.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:47:0) after 1m0s
[20:48:13.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:47:0)
[20:48:13.061] Timer tick, asking Buildbucket for the build status
[20:48:13.159] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:13.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:48:0) after 1m0s
[20:49:13.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:48:0)
[20:49:13.187] Timer tick, asking Buildbucket for the build status
[20:49:13.280] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:13.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:49:0) after 1m0s
[20:50:13.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:49:0)
[20:50:13.373] Timer tick, asking Buildbucket for the build status
[20:50:13.425] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:13.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:50:0) after 1m0s
[20:51:13.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:50:0)
[20:51:13.507] Timer tick, asking Buildbucket for the build status
[20:51:13.615] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:13.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:51:0) after 1m0s
[20:52:13.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:51:0)
[20:52:13.742] Timer tick, asking Buildbucket for the build status
[20:52:14.203] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:14.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:52:0) after 1m0s
[20:53:14.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:52:0)
[20:53:14.253] Timer tick, asking Buildbucket for the build status
[20:53:14.545] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:14.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:53:0) after 1m0s
[20:54:14.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:53:0)
[20:54:14.612] Timer tick, asking Buildbucket for the build status
[20:54:14.733] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:14.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:54:0) after 1m0s
[20:55:14.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:54:0)
[20:55:14.758] Timer tick, asking Buildbucket for the build status
[20:55:14.867] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:14.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:55:0) after 1m0s
[20:56:14.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:55:0)
[20:56:14.874] Timer tick, asking Buildbucket for the build status
[20:56:14.949] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:14.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:56:0) after 1m0s
[20:57:14.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:56:0)
[20:57:14.940] Timer tick, asking Buildbucket for the build status
[20:57:15.064] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:15.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:57:0) after 1m0s
[20:58:15.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:57:0)
[20:58:15.172] Timer tick, asking Buildbucket for the build status
[20:58:15.283] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:15.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:58:0) after 1m0s
[20:59:15.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:58:0)
[20:59:15.369] Timer tick, asking Buildbucket for the build status
[20:59:15.459] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:15.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:59:0) after 1m0s
[21:00:15.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:59:0)
[21:00:15.615] Timer tick, asking Buildbucket for the build status
[21:00:15.794] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:15.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:60:0) after 1m0s
[21:01:15.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:60:0)
[21:01:15.871] Timer tick, asking Buildbucket for the build status
[21:01:16.194] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:16.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:61:0) after 1m0s
[21:02:16.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:61:0)
[21:02:16.316] Timer tick, asking Buildbucket for the build status
[21:02:16.409] Build 8856741024627826864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022171086654195136:62:0) after 1m0s
[21:02:39.317] Received PubSub notification, asking Buildbucket for the build status
[21:02:39.812] Build 8856741024627826864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:02:39.812] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611954158495589",
"created_by": "project:chromium",
"created_ts": "1611950579958630",
"id": "8856741024627826864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\"}}",
"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\": \"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-174-bw0z\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180108, \"got_angle_revision\": \"a29ef6129501a14774387f23574d30459b70f9e6\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\", \"got_revision_cp\": \"refs/heads/master@{#848662}\", \"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\": \"cbb3aabc53bec0e1d11795fdb5d62294375dcca9\", \"swarm_hashes_refs/heads/master(at){#848662}_without_patch\": {\"absl_hardening_tests\": \"10a1ae4f2a3ba32fb81ff30733cacbce81641c0f\", \"accessibility_unittests\": \"eec5f1c7767b5b1850b7ca0d07192eff522c45fe\", \"angle_unittests\": \"3f3dfebfed7be0069041401e38a3e5118fd68d7a\", \"app_shell_unittests\": \"e09ae19419f09776b1d37f66b7bea4b844e6522b\", \"aura_unittests\": \"f4037e65eebccd722f182062c557c91164cf81b7\", \"base_unittests\": \"054dc1c6a60ada49b08e478d65af2850c35400c1\", \"base_util_unittests\": \"d27a63a2b2b72d1ad654f557a8a19edf23bbc646\", \"blink_common_unittests\": \"b82fb85cfc08a8e682146d778d0a09da61102238\", \"blink_fuzzer_unittests\": \"af0886d410d163844610d2001c7496a36409edf9\", \"blink_heap_unittests\": \"e5d1d5edf86a622f219f59390c097b1ae062f9df\", \"blink_platform_unittests\": \"1a8b20cd25f3eca08ae2ffb760953f1734610b4c\", \"blink_python_tests\": \"ff235a8bba490fd6e164fdbb8fabc9b8df2b2353\", \"blink_unittests\": \"f856f75cd6723699eb02f1e0a68c7751486f8427\", \"blink_web_tests\": \"d108fb7f3c4c3c00f982c0d6ffb622a9bf91389a\", \"boringssl_crypto_tests\": \"38432bc7a3178221c6677a9737e3979c83a8c2d2\", \"boringssl_ssl_tests\": \"ba73df33a12f45b0bf764f1e53b986a6fdfe86bb\", \"browser_tests\": \"d7854d05130f1bfb78f32c6aecda770e9115690d\", \"capture_unittests\": \"2f5b2cdeb9adf68f0af3c7589a0bab0f283a3860\", \"cast_unittests\": \"45fc187cecd5d02dafa95440879d79224005defb\", \"cc_unittests\": \"4bd0885f1b9d8b9508ca8c907976aa528972d5cc\", \"chrome_app_unittests\": \"4771442bc2d52e28d194fd04c3efbfa899b76bc0\", \"chromedriver_unittests\": \"58cc6f8d068719270916249d313b4b0d126175c1\", \"components_browsertests\": \"95ee8866a61ead88ee1b733cfd323effcfbf5187\", \"components_unittests\": \"7501493dd86efc0acfecc15a857eeecbe926e83f\", \"compositor_unittests\": \"6bcc72a79ba4486f43e11bfddc8fa819794b5d90\", \"content_browsertests\": \"258d5e9c1a6ce32818592cf175cbc4141c1fa312\", \"content_shell_crash_test\": \"559475d0872bdaf6253e31d064d5405e2cdc62e1\", \"content_unittests\": \"2433ddf423ecb6541961babdda7d895bcd871042\", \"crashpad_tests\": \"5cadfcb4e8d638d034cb102236cc9461a0153d7c\", \"cronet_tests\": \"6b2884f88ba10e4db0d6743a2aa3d9bbddc01fb2\", \"cronet_unittests\": \"79fccabbc269cfd07c398c14ac52c3435f79881e\", \"crypto_unittests\": \"dba8f897c83c18760a0151e1385cb7f763933fc2\", \"dbus_unittests\": \"26b4499d05c8b3f60f78dce0082314914ab20131\", \"device_unittests\": \"daf3218a15155ff81df3bef23e2e6b6cccaac0cc\", \"display_unittests\": \"0a16b1cbf3d5514220be4f1f9f07480e3a7a4f2b\", \"events_unittests\": \"dde8f31bd5a70011127d0d1b1ee10a7cd323e11d\", \"extensions_browsertests\": \"07f307cdcfb4adca193792edf056d4e774482e56\", \"extensions_unittests\": \"da561c0f8f6d9c7ed4c1e8577b5e17d683a51b3d\", \"filesystem_service_unittests\": \"d9c5ef9d6e2b1a511401c001497146bcc413d1e6\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"e5b7e676c02063e9c42167ad01e4396bb87a77b2\", \"gfx_unittests\": \"42773bc3be341ff92cfae2ff68d19743f8f70638\", \"gin_unittests\": \"74fc41353d427ad9ba8d8b8161f37b5d41fcd3a3\", \"google_apis_unittests\": \"f26a11e03f87c66ece7c9b21da7befbfbd6e5627\", \"gpu_unittests\": \"a1a8dd16b034306ed647551a092958c56569f159\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"f1e11df59c196aa0d57155c386c1a1f4f3434959\", \"headless_browsertests\": \"889033b029c4ee10a4c1a7609d636807f709a426\", \"headless_unittests\": \"820159e98acf172d676d7a65846b60ebd598635e\", \"interactive_ui_tests\": \"7e713e2acb0f102d7499829f41bade3a1fc65694\", \"ipc_tests\": \"a2227aeef533f13c937c035b87f52a4f5c067635\", \"jingle_unittests\": \"954a5dfa6d1e9f2caf7ae51d079b3777fe3187fe\", \"latency_unittests\": \"d7a8693af3694a2268013f08131d1234427c4af9\", \"libjingle_xmpp_unittests\": \"4d5a82b4b3ed16a0dacc034caa6c8a03fe681f0e\", \"liburlpattern_unittests\": \"04cc8c32f4584712d9448588eb400b1b18fe2d30\", \"media_blink_unittests\": \"95db54b81cf9462da95288f9464b1a0f05bacdef\", \"media_unittests\": \"33caffbc89d459915aff870ccc6f5646e4f51ccb\", \"message_center_unittests\": \"861d97dfffa8968e5e162db064016c7b6878d484\", \"metrics_python_tests\": \"2ad269d2451cc4b52c5f114b8c9d39bda0546ee1\", \"midi_unittests\": \"1485b55299c7abc6a81bfa92745924ed5b85c151\", \"mojo_core_unittests\": \"261109d8b9542c7b127a3b62585b8ee87dc6c2ee\", \"mojo_unittests\": \"7ed52dbad10dacaf9b5ca90764151c6a3f307c64\", \"nacl_helper_nonsfi_unittests\": \"b2e6ead31e5f5b2f791fb22283ed4bc969e33fa1\", \"nacl_loader_unittests\": \"8891e8a2e359b6bbe95703532efb96641242841c\", \"native_theme_unittests\": \"2419e258063032b3769fab4fd9c94fb0f619e47e\", \"net_unittests\": \"2c9eec7d8e285bd3645d8d478ec4557124257d48\", \"openscreen_unittests\": \"20cb8e589a33078861f57ee69c9aceca06f3b594\", \"pdf_unittests\": \"eb1663a115125f7146ea188bebdb4c3af7ef5676\", \"perfetto_unittests\": \"5f2516ce663d05f8004195c5fee2c034b7711ba7\", \"ppapi_unittests\": \"c3e310f4169dbab1e3695c1032bfbb1172b729dc\", \"printing_unittests\": \"dd55a02d0ac7bea60e76b2779dddf6ee0b6e369e\", \"remoting_unittests\": \"ba1a238cf6380c3932fa5a98a1324e53d366eb35\", \"sandbox_linux_unittests\": \"216b2f637ae24965970adb227e192f71a6dbb654\", \"service_manager_unittests\": \"2897f3b946517ebbfb6964a4732f78cccab988fb\", \"services_unittests\": \"fecca4d02b6d368238031ae5056f09ded5384fc5\", \"shell_dialogs_unittests\": \"c67d93c712ad8968234217b12c420dd345e5ebef\", \"skia_unittests\": \"5f818b70217905d8e4399944cba4601d8f45d26c\", \"snapshot_unittests\": \"07df4b6ff9e89cb8563c1c4a13a8bfeb59173a4f\", \"sql_unittests\": \"6ad310fdb8a69f17284fc8fb2512e801625509c3\", \"storage_unittests\": \"83be1df9e46572e92031026dcf4e17b65453d63e\", \"sync_integration_tests\": \"4febfbd252cc1627dd9c5719035c9d5ecc322202\", \"telemetry_gpu_unittests\": \"9721f6dcae41356a73e73bd3b4cd20ff9d42157d\", \"telemetry_perf_unittests\": \"4c9c8e290e57f949046027f15bfea438370dc2a6\", \"telemetry_unittests\": \"bd0fa98d3421c215f51873d896dffda2725239ea\", \"traffic_annotation_auditor_unittests\": \"71a01ef466508e47b5cf2ef52d2cfdaf1efd24ab\", \"ui_base_unittests\": \"af25e52558dcb8a13954dc03629f546d43089dbd\", \"ui_touch_selection_unittests\": \"6068f28c7c419e948a7dfeb3911ff67390b9c861\", \"unit_tests\": \"95c49a66b6109fe6cc1ba733dd27b054d7c99629\", \"url_unittests\": \"8ce9d8805c750a92862f395bb6f77a9ac4e152bc\", \"views_perftests\": \"8c437488c7292ff47e8f1cafdf77b35c5125f9d5\", \"views_unittests\": \"04891bd7b8d68742806dd6a57bd8c349256160a3\", \"viz_unittests\": \"48e6762dc3dc3fb526d18cd3ba421598dfc2243e\", \"vr_common_unittests\": \"a79c487a2d21a361ce5345bccde5039e917a134e\", \"vr_pixeltests\": \"cfdf31690db3fe7cf6a451b076a715b0db0d8acf\", \"webdriver_wpt_tests\": \"d67d3f026fbfd504464e61dbdb6768fc3452e606\", \"weblayer_browsertests\": \"e3cc4801ba57184060d29a1a8b97e75e419b47cf\", \"weblayer_unittests\": \"d0d03bb04c26af57b329026f7e7d3db88afa9a3b\", \"wm_unittests\": \"caa5a8cda284c6736b127740f24767f242dca98d\", \"wtf_unittests\": \"f180063d26654e66622d1ebece2a0b3d31b65b0a\", \"x11_unittests\": \"d56f85d9d2739ee3ef12a5022267c38ab22eb528\", \"xr_browser_tests\": \"49365dc4d229d75660042fe6c98632bb238d4418\", \"zlib_unittests\": \"4d923ea489decf562d3a0bfaa0deb87de59761be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_b60086edde2d210abd33c4d80848a46b6d9127aed49992e1b3da5a4d0158dc58_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-174-bw0z\"], \"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": "1611950585529898",
"status": "COMPLETED",
"status_changed_ts": "1611954159060460",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180108",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cbb3aabc53bec0e1d11795fdb5d62294375dcca9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022171086654195136",
"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/8856741024627826864/+/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:51688f6d980f4710",
"user_agent:luci-scheduler"
],
"updated_ts": "1611954159064431",
"url": "https://ci.chromium.org/b/8856741024627826864",
"utcnow_ts": "1611954159750999"
}
}
[21:02:39.812] Invocation finished in 59m41.170493503s with status SUCCEEDED