[20:06:00.112] New invocation is queued and will start shortly
[20:06:01.245] Starting the invocation (attempt 1)
[20:06:01.322] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:06:01.322] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:06:01.322] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022533284253788080",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cfe7d78319cf2f41cca83da4357acab2d4db82bf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022533284253788080",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"gitiles_ref:refs/heads/master"
]
}
[20:06:02.686] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611605161481130",
"id": "8857103222153157072",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfe7d78319cf2f41cca83da4357acab2d4db82bf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611605162503120",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179970",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022533284253788080",
"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/8857103222153157072/+/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": "1611605162503262",
"url": "https://ci.chromium.org/b/8857103222153157072",
"utcnow_ts": "1611605162678491"
}
}
[20:06:02.686] Task URL: https://ci.chromium.org/b/8857103222153157072
[20:06:02.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:2:0) after 1m0s
[20:06:22.349] Received PubSub notification, asking Buildbucket for the build status
[20:06:22.487] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:02.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:2:0)
[20:07:02.745] Timer tick, asking Buildbucket for the build status
[20:07:03.919] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:03.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:4:0) after 1m0s
[20:08:03.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:4:0)
[20:08:03.997] Timer tick, asking Buildbucket for the build status
[20:08:04.204] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:04.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:5:0) after 1m0s
[20:09:04.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:5:0)
[20:09:04.246] Timer tick, asking Buildbucket for the build status
[20:09:04.306] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:04.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:6:0) after 1m0s
[20:10:04.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:6:0)
[20:10:04.381] Timer tick, asking Buildbucket for the build status
[20:10:05.149] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:05.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:7:0) after 1m0s
[20:11:05.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:7:0)
[20:11:05.185] Timer tick, asking Buildbucket for the build status
[20:11:05.497] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:05.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:8:0) after 1m0s
[20:12:05.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:8:0)
[20:12:05.562] Timer tick, asking Buildbucket for the build status
[20:12:05.760] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:05.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:9:0) after 1m0s
[20:13:05.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:9:0)
[20:13:05.805] Timer tick, asking Buildbucket for the build status
[20:13:06.035] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:10:0) after 1m0s
[20:14:06.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:10:0)
[20:14:06.122] Timer tick, asking Buildbucket for the build status
[20:14:06.400] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:06.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:11:0) after 1m0s
[20:15:06.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:11:0)
[20:15:06.467] Timer tick, asking Buildbucket for the build status
[20:15:06.735] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:06.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:12:0) after 1m0s
[20:16:06.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:12:0)
[20:16:06.745] Timer tick, asking Buildbucket for the build status
[20:16:07.593] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:13:0) after 1m0s
[20:17:07.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:13:0)
[20:17:07.702] Timer tick, asking Buildbucket for the build status
[20:17:07.840] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:07.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:14:0) after 1m0s
[20:18:07.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:14:0)
[20:18:07.914] Timer tick, asking Buildbucket for the build status
[20:18:08.057] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:08.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:15:0) after 1m0s
[20:19:08.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:15:0)
[20:19:08.231] Timer tick, asking Buildbucket for the build status
[20:19:08.300] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:08.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:16:0) after 1m0s
[20:20:08.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:16:0)
[20:20:08.438] Timer tick, asking Buildbucket for the build status
[20:20:08.490] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:08.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:17:0) after 1m0s
[20:21:08.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:17:0)
[20:21:08.545] Timer tick, asking Buildbucket for the build status
[20:21:08.691] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:08.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:18:0) after 1m0s
[20:22:08.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:18:0)
[20:22:08.734] Timer tick, asking Buildbucket for the build status
[20:22:08.796] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:08.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:19:0) after 1m0s
[20:23:08.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:19:0)
[20:23:08.876] Timer tick, asking Buildbucket for the build status
[20:23:08.957] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:08.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:20:0) after 1m0s
[20:24:08.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:20:0)
[20:24:08.970] Timer tick, asking Buildbucket for the build status
[20:24:10.590] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:10.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:21:0) after 1m0s
[20:25:10.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:21:0)
[20:25:10.627] Timer tick, asking Buildbucket for the build status
[20:25:10.751] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:10.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:22:0) after 1m0s
[20:26:10.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:22:0)
[20:26:10.813] Timer tick, asking Buildbucket for the build status
[20:26:10.940] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:10.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:23:0) after 1m0s
[20:27:11.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:23:0)
[20:27:11.029] Timer tick, asking Buildbucket for the build status
[20:27:11.719] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:24:0) after 1m0s
[20:28:11.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:24:0)
[20:28:11.761] Timer tick, asking Buildbucket for the build status
[20:28:11.831] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:11.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:25:0) after 1m0s
[20:29:11.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:25:0)
[20:29:11.914] Timer tick, asking Buildbucket for the build status
[20:29:12.107] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:26:0) after 1m0s
[20:30:12.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:26:0)
[20:30:12.187] Timer tick, asking Buildbucket for the build status
[20:30:12.288] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:27:0) after 1m0s
[20:31:12.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:27:0)
[20:31:12.366] Timer tick, asking Buildbucket for the build status
[20:31:12.687] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:12.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:28:0) after 1m0s
[20:32:12.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:28:0)
[20:32:12.693] Timer tick, asking Buildbucket for the build status
[20:32:12.745] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:12.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:29:0) after 1m0s
[20:33:12.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:29:0)
[20:33:12.780] Timer tick, asking Buildbucket for the build status
[20:33:13.324] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:13.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:30:0) after 1m0s
[20:34:13.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:30:0)
[20:34:13.355] Timer tick, asking Buildbucket for the build status
[20:34:13.439] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:13.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:31:0) after 1m0s
[20:35:13.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:31:0)
[20:35:13.508] Timer tick, asking Buildbucket for the build status
[20:35:13.587] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:13.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:32:0) after 1m0s
[20:36:13.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:32:0)
[20:36:13.598] Timer tick, asking Buildbucket for the build status
[20:36:13.730] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:13.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:33:0) after 1m0s
[20:37:13.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:33:0)
[20:37:13.780] Timer tick, asking Buildbucket for the build status
[20:37:14.011] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:14.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:34:0) after 1m0s
[20:38:14.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:34:0)
[20:38:14.084] Timer tick, asking Buildbucket for the build status
[20:38:14.162] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:14.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:35:0) after 1m0s
[20:39:14.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:35:0)
[20:39:14.157] Timer tick, asking Buildbucket for the build status
[20:39:15.878] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:15.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:36:0) after 1m0s
[20:40:15.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:36:0)
[20:40:15.880] Timer tick, asking Buildbucket for the build status
[20:40:15.941] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:15.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:37:0) after 1m0s
[20:41:15.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:37:0)
[20:41:15.982] Timer tick, asking Buildbucket for the build status
[20:41:16.066] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:38:0) after 1m0s
[20:42:16.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:38:0)
[20:42:16.098] Timer tick, asking Buildbucket for the build status
[20:42:16.184] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:16.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:39:0) after 1m0s
[20:43:16.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:39:0)
[20:43:16.260] Timer tick, asking Buildbucket for the build status
[20:43:16.329] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:16.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:40:0) after 1m0s
[20:44:16.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:40:0)
[20:44:16.420] Timer tick, asking Buildbucket for the build status
[20:44:16.646] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:16.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:41:0) after 1m0s
[20:45:16.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:41:0)
[20:45:16.708] Timer tick, asking Buildbucket for the build status
[20:45:16.955] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:42:0) after 1m0s
[20:46:16.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:42:0)
[20:46:16.963] Timer tick, asking Buildbucket for the build status
[20:46:17.634] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:17.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:43:0) after 1m0s
[20:47:17.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:43:0)
[20:47:17.742] Timer tick, asking Buildbucket for the build status
[20:47:17.892] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:44:0) after 1m0s
[20:48:17.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:44:0)
[20:48:17.911] Timer tick, asking Buildbucket for the build status
[20:48:18.600] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:18.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:45:0) after 1m0s
[20:49:18.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:45:0)
[20:49:18.919] Timer tick, asking Buildbucket for the build status
[20:49:19.003] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:19.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:46:0) after 1m0s
[20:50:19.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:46:0)
[20:50:19.477] Timer tick, asking Buildbucket for the build status
[20:50:19.957] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:19.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:47:0) after 1m0s
[20:51:20.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:47:0)
[20:51:20.027] Timer tick, asking Buildbucket for the build status
[20:51:20.184] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:20.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:48:0) after 1m0s
[20:52:20.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:48:0)
[20:52:20.268] Timer tick, asking Buildbucket for the build status
[20:52:20.518] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:20.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:49:0) after 1m0s
[20:53:20.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:49:0)
[20:53:20.564] Timer tick, asking Buildbucket for the build status
[20:53:20.653] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:20.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:50:0) after 1m0s
[20:54:21.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:50:0)
[20:54:21.234] Timer tick, asking Buildbucket for the build status
[20:54:21.831] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:21.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:51:0) after 1m0s
[20:55:21.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:51:0)
[20:55:21.853] Timer tick, asking Buildbucket for the build status
[20:55:21.997] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:21.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:52:0) after 1m0s
[20:56:22.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:52:0)
[20:56:22.067] Timer tick, asking Buildbucket for the build status
[20:56:22.178] Build 8857103222153157072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:22.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022533284253788080:53:0) after 1m0s
[20:57:10.190] Received PubSub notification, asking Buildbucket for the build status
[20:57:10.285] Build 8857103222153157072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:57:10.285] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611608229494100",
"created_by": "project:chromium",
"created_ts": "1611605161481130",
"id": "8857103222153157072",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfe7d78319cf2f41cca83da4357acab2d4db82bf\"}}",
"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\": \"cfe7d78319cf2f41cca83da4357acab2d4db82bf\", \"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-45-90gc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179970, \"got_angle_revision\": \"3623868e656d0685f0ec3f7d13a2e9c1e348ba53\", \"got_dawn_revision\": \"c00276b2029b85b0cca43ced05173993beaf43e7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"cfe7d78319cf2f41cca83da4357acab2d4db82bf\", \"got_revision_cp\": \"refs/heads/master@{#846846}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"07aeb34c380e82877710ad10e53596c41c49abd3\", \"got_v8_revision_cp\": \"refs/heads/9.0.61@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfe7d78319cf2f41cca83da4357acab2d4db82bf\", \"swarm_hashes_refs/heads/master(at){#846846}_without_patch\": {\"absl_hardening_tests\": \"9684ab6be75b01321415f2c40b6a1c4749998cd6\", \"accessibility_unittests\": \"1c145ea78ca533958d43ec3da78e8edd4e5de0b0\", \"angle_unittests\": \"48b923e87403b48aab7db19a5c503e52c584a392\", \"app_shell_unittests\": \"efac779e94d6900848670477891529d313f9ae8b\", \"aura_unittests\": \"e0b590f0b22986554ca25a5093e86a9c148497b0\", \"base_unittests\": \"407a28a59dd45e2dd5b173a4bbd9db84cac2aa3e\", \"base_util_unittests\": \"fc0826f314dd4aa18bf62096dd67007af726ad25\", \"blink_common_unittests\": \"4e05d56494599e7f4a682cbcb4c0c1d5baae658f\", \"blink_fuzzer_unittests\": \"d16cd5780fdaa0047b7f2342309203fccc83a8ca\", \"blink_heap_unittests\": \"a59b23aeb80dba36674c1c2aeb34a6619c2df1fd\", \"blink_platform_unittests\": \"d02246196a8c026e613606cfc2c5d8382ed8fb08\", \"blink_python_tests\": \"2aacfdae0dbe4d06afa774b523dc73a62d53509c\", \"blink_unittests\": \"ab653c3890484d773b21f1f722f72e0c9f77a4b6\", \"blink_web_tests\": \"1dc988b4b5408532f6301990d289afdea1f61393\", \"boringssl_crypto_tests\": \"9948359f2c735f08e04485668af93ca3b8af7cfb\", \"boringssl_ssl_tests\": \"1b85ce8a490860b1e4e498e9ece8188f07cac535\", \"browser_tests\": \"618d4d2d33c240a663436349db10fc7ba683addf\", \"capture_unittests\": \"a0e5273a23f6a9b594d8a23a2413efe1bbf9548a\", \"cast_unittests\": \"2c561f9075abfe6d33e0062a45332891755f3afb\", \"cc_unittests\": \"1b5f0695b77ad8056ed5eae13eaeddd96749eb7f\", \"chrome_app_unittests\": \"3fabb402aa5b0eb18a9215e1fd07ec62a0aa0230\", \"chromedriver_unittests\": \"681c5e93c5c9706f89236de78c0aac1880ceb4b0\", \"components_browsertests\": \"8efb4ae3f70687b765520ca012a7c63fbcb10878\", \"components_unittests\": \"5c21ff2e7694580250ae9535b3b8f7bee96ef301\", \"compositor_unittests\": \"dac25c8b7237a9d39fb770bbd817bf596fca5860\", \"content_browsertests\": \"17ffec796116c908bfa874100c020b246a23a28b\", \"content_shell_crash_test\": \"b284eb822641c71419d1cf8215b5626d3a323aaa\", \"content_unittests\": \"8e2084e490a3d99b8354b06a51197474f7f835e7\", \"crashpad_tests\": \"c5bb6982151a66ef585d3e07dab5345f12243904\", \"cronet_tests\": \"f5d2116b9c51430ba22c8f17c0ebade2679d2a51\", \"cronet_unittests\": \"065105a4636c53b6c8fbf1b0f833e42131735469\", \"crypto_unittests\": \"d541b6b5300bef7a15657040a1dffbf206615736\", \"dbus_unittests\": \"380ee42d7bf2c1b5d3662f61bb06403f705cc16f\", \"device_unittests\": \"443c1775460d068f3291957eede6b21650dbd9f9\", \"display_unittests\": \"19bfdbba6d28a127b4966501fcac10bc642231dc\", \"events_unittests\": \"59aedad1f90f6ff86b070b65e1b7199fa85b6199\", \"extensions_browsertests\": \"0a2e9125f4752cf3f4aca19cd96b15982b8abb5a\", \"extensions_unittests\": \"61f885b1ea19b2dc5852c4693d62ee4355c044ee\", \"filesystem_service_unittests\": \"599f6e1c1db6e6ee57a6b83644fa2aa0fdc2c881\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"bad9a871179a0c2ab62a9d35e8f8773160771b72\", \"gfx_unittests\": \"de880bf840f1ce989027f170a7d8d1fa22cb5f16\", \"gin_unittests\": \"b391e8d85d9c3ad836214f45eb9ddeaec1ea0b74\", \"google_apis_unittests\": \"025600c6488e68fbdbede14bb1e2fe17c8cf3dde\", \"gpu_unittests\": \"c7721fb7d008d7748c15af0495d9f2befc82d4bc\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"66793ccf34155e6bab10e7069a46bc05f533cb66\", \"headless_browsertests\": \"b5dc31f1163501577e9df04d88f1dfa8363f7584\", \"headless_unittests\": \"106e551c3146d28cd9d7d141db9b3f9f0426d989\", \"interactive_ui_tests\": \"119e75fe3eee60b3d7fa56e1ac2c76d3375be69d\", \"ipc_tests\": \"7d945e9ef0203b5868d9a690b2a6fc21b0212c1a\", \"jingle_unittests\": \"266f2e5918bfc53a601596ae9a45baa12e2c147f\", \"latency_unittests\": \"619ceb24adbe489e8e97c7ac85c5d935a9fff99b\", \"libjingle_xmpp_unittests\": \"d16efb5a3ef73b6b06425cf37c13da5cbc0ac39e\", \"liburlpattern_unittests\": \"dcba2436ddd9d30f215149650fc524ffc3f3c53c\", \"media_blink_unittests\": \"3bf602ae1249814aafd9e7155ee5eda7fe9978e1\", \"media_unittests\": \"1d7238ffc0094fb9f25f1c24ff01e67566f0a1a9\", \"message_center_unittests\": \"9de3b36a44c8e644485dba418b1ebdb60dfa4897\", \"metrics_python_tests\": \"3c2e3673ebcb5573f2d67278ed80c3448ec06d05\", \"midi_unittests\": \"e469e5a10728644a38c1d9a3dfedc6f956b344a3\", \"mojo_core_unittests\": \"92cb00258ff355894722dd97c979971cdb9bc1e3\", \"mojo_unittests\": \"8fd6a7445d4a9ca7bfa44cd0ed3d24faef24bb49\", \"nacl_helper_nonsfi_unittests\": \"7cdce20f8a7aa808cdb69040964a7434a5a583a9\", \"nacl_loader_unittests\": \"d04d1a9b7130735fae50e10212472c18a3da956d\", \"native_theme_unittests\": \"b7717406bbbbf005ba93c6323c33da1d650550c6\", \"net_unittests\": \"060cb52096e2ed24ef4e234c950a1efa1f103567\", \"openscreen_unittests\": \"91b7a2800f40307ca0fa13f1fe6cb294a8233127\", \"pdf_unittests\": \"8016eb0815d5fd60652f928891d11b6c60f5c61a\", \"perfetto_unittests\": \"089a0ad5dcadd3e9f75162b9e10a2ee97c8e300a\", \"ppapi_unittests\": \"263b60fe9c260593f84361660925c3eae64e1022\", \"printing_unittests\": \"1d0bb8b6d8b97b8ecc1bf245aef580c9f532a9d7\", \"remoting_unittests\": \"75f8729f6419c487731775223593e78e4cd0ed85\", \"sandbox_linux_unittests\": \"427f1b12cfbd98bff817c7457344655fdfa12fe7\", \"service_manager_unittests\": \"5da76ac54b5d1ffa9d15830d583b03cdbfaacc16\", \"services_unittests\": \"576f78e8a6d0cfd6c6501be62fbc5fc2ac088df5\", \"shell_dialogs_unittests\": \"b300bb9efe95d046f7d433075df071a276d9231e\", \"skia_unittests\": \"d3b43829d5d42877b61b1927b1f3f8b04626c177\", \"snapshot_unittests\": \"b819a536d1370481872e27ff75ad5428c36b83d5\", \"sql_unittests\": \"2743d6a6b1b50a331ede7683b108eb93484fabb8\", \"storage_unittests\": \"1d52c7b15f804cc1ec4d17f59570101ed2bb045c\", \"sync_integration_tests\": \"31424fb5339ff6c533473afd44bde5eb3f365b9e\", \"telemetry_gpu_unittests\": \"dbb0087f19575deba972045b6f9d2c156a73d9fb\", \"telemetry_perf_unittests\": \"2dfaa1190a5a3c911ba0358f2bc5e45b9ee18a38\", \"telemetry_unittests\": \"d6a0d29bef50c605a5c4de1ff827d52a190085e1\", \"traffic_annotation_auditor_unittests\": \"a181d9c20238ba98d6ea4c4350ce699fc247f765\", \"ui_base_unittests\": \"4c41f844b7af0fae7f8a740d0b3a0b50ece76f9e\", \"ui_touch_selection_unittests\": \"26cbfc4bfa7656eabf5334160d77e7d23e7762b1\", \"unit_tests\": \"5ffcd1ec02df5a4794bc8092c38b8e2213b12dc9\", \"url_unittests\": \"6020f36696737b0125ba7cd2dca9a22240acdae4\", \"views_perftests\": \"6bb64977f9c5b4d562780f6efd0f148e13b04ea8\", \"views_unittests\": \"d82bfdf9bdef3fa12391f34f98c9005cda942f80\", \"viz_unittests\": \"3263baf551cb5621762b9e1a74a0292cb9f88061\", \"vr_common_unittests\": \"6821425b4ac63f43bea740fd367ea252a47c84c0\", \"vr_pixeltests\": \"bed436b4b7ed1ed2b4a2c9cca8291f7b5bf49494\", \"webdriver_wpt_tests\": \"3bc7386413790a9258aa9ba1421efee5b6972da3\", \"weblayer_browsertests\": \"7f0e7eec48f702cc9a5c3c0af0a469820119b364\", \"weblayer_unittests\": \"2566e7a0f1d37d266fdc0f121b40dfa1f7a8bde7\", \"wm_unittests\": \"aee57800ed25a08963ecabdb79ed97beb71fd48e\", \"wtf_unittests\": \"18eff9ba345aa6fe112a4a42b488004480ff2cdd\", \"x11_unittests\": \"dd11334161948a50525d5d429b6e05739aa580d4\", \"xr_browser_tests\": \"fa64957e08a4416e65e01c7b80ee9b438618ec75\", \"zlib_unittests\": \"8a110fd9bef3a4af13d585c66591c7e06f2a7217\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_6cd5ded23cefc640ae511b7a529237cb2561e39c1afb96e401c63016ddcf35a6_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_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-45-90gc\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611605181098437",
"status": "COMPLETED",
"status_changed_ts": "1611608229893621",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179970",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfe7d78319cf2f41cca83da4357acab2d4db82bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022533284253788080",
"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/8857103222153157072/+/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:5153f8c334938510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611608229916003",
"url": "https://ci.chromium.org/b/8857103222153157072",
"utcnow_ts": "1611608230275832"
}
}
[20:57:10.285] Invocation finished in 51m10.191092576s with status SUCCEEDED