[14:39:01.001] New invocation is queued and will start shortly
[14:39:02.061] Starting the invocation (attempt 1)
[14:39:02.124] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:39:02.124] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:39:02.124] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017933411094963712",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"82b43210b6a7221dcca80749a4c4db14d5c7a214\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9017933411094963712",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"gitiles_ref:refs/heads/master"
]
}
[14:39:02.763] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615991942263303",
"id": "8852503349107646080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82b43210b6a7221dcca80749a4c4db14d5c7a214\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615991942619808",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181456",
"builder:Linux Builder (dbg)",
"buildset:commit/git/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017933411094963712",
"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/8852503349107646080/+/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": "1615991942619923",
"url": "https://ci.chromium.org/b/8852503349107646080",
"utcnow_ts": "1615991942754713"
}
}
[14:39:02.763] Task URL: https://ci.chromium.org/b/8852503349107646080
[14:39:02.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:2:0) after 1m0s
[14:39:24.643] Received PubSub notification, asking Buildbucket for the build status
[14:39:28.509] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:02.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:2:0)
[14:40:02.782] Timer tick, asking Buildbucket for the build status
[14:40:02.845] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:4:0) after 1m0s
[14:41:03.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:4:0)
[14:41:03.059] Timer tick, asking Buildbucket for the build status
[14:41:03.123] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:03.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:5:0) after 1m0s
[14:42:03.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:5:0)
[14:42:03.360] Timer tick, asking Buildbucket for the build status
[14:42:03.465] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:03.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:6:0) after 1m0s
[14:43:03.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:6:0)
[14:43:03.509] Timer tick, asking Buildbucket for the build status
[14:43:03.605] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:03.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:7:0) after 1m0s
[14:44:03.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:7:0)
[14:44:03.751] Timer tick, asking Buildbucket for the build status
[14:44:03.823] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:03.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:8:0) after 1m0s
[14:45:03.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:8:0)
[14:45:03.878] Timer tick, asking Buildbucket for the build status
[14:45:03.958] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:03.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:9:0) after 1m0s
[14:46:04.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:9:0)
[14:46:04.048] Timer tick, asking Buildbucket for the build status
[14:46:04.184] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:04.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:10:0) after 1m0s
[14:47:04.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:10:0)
[14:47:04.258] Timer tick, asking Buildbucket for the build status
[14:47:04.361] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:04.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:11:0) after 1m0s
[14:48:04.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:11:0)
[14:48:04.377] Timer tick, asking Buildbucket for the build status
[14:48:04.462] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:04.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:12:0) after 1m0s
[14:49:04.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:12:0)
[14:49:04.485] Timer tick, asking Buildbucket for the build status
[14:49:04.915] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:04.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:13:0) after 1m0s
[14:50:05.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:13:0)
[14:50:05.019] Timer tick, asking Buildbucket for the build status
[14:50:05.113] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:05.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:14:0) after 1m0s
[14:51:06.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:14:0)
[14:51:06.029] Timer tick, asking Buildbucket for the build status
[14:51:06.122] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:06.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:15:0) after 1m0s
[14:52:06.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:15:0)
[14:52:06.182] Timer tick, asking Buildbucket for the build status
[14:52:06.283] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:06.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:16:0) after 1m0s
[14:53:06.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:16:0)
[14:53:06.380] Timer tick, asking Buildbucket for the build status
[14:53:06.613] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:06.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:17:0) after 1m0s
[14:54:06.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:17:0)
[14:54:06.719] Timer tick, asking Buildbucket for the build status
[14:54:06.846] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:06.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:18:0) after 1m0s
[14:55:06.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:18:0)
[14:55:06.889] Timer tick, asking Buildbucket for the build status
[14:55:06.957] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:06.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:19:0) after 1m0s
[14:56:07.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:19:0)
[14:56:07.005] Timer tick, asking Buildbucket for the build status
[14:56:07.206] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:07.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:20:0) after 1m0s
[14:57:07.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:20:0)
[14:57:07.262] Timer tick, asking Buildbucket for the build status
[14:57:07.345] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:07.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:21:0) after 1m0s
[14:58:07.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:21:0)
[14:58:07.412] Timer tick, asking Buildbucket for the build status
[14:58:07.529] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:07.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:22:0) after 1m0s
[14:59:07.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:22:0)
[14:59:07.525] Timer tick, asking Buildbucket for the build status
[14:59:07.650] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:07.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:23:0) after 1m0s
[15:00:07.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:23:0)
[15:00:07.705] Timer tick, asking Buildbucket for the build status
[15:00:08.273] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:08.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:24:0) after 1m0s
[15:01:08.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:24:0)
[15:01:08.384] Timer tick, asking Buildbucket for the build status
[15:01:08.610] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:08.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:25:0) after 1m0s
[15:02:08.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:25:0)
[15:02:08.664] Timer tick, asking Buildbucket for the build status
[15:02:08.798] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:08.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:26:0) after 1m0s
[15:03:08.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:26:0)
[15:03:08.776] Timer tick, asking Buildbucket for the build status
[15:03:08.867] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:27:0) after 1m0s
[15:04:08.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:27:0)
[15:04:08.885] Timer tick, asking Buildbucket for the build status
[15:04:09.069] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:09.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:28:0) after 1m0s
[15:05:09.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:28:0)
[15:05:09.096] Timer tick, asking Buildbucket for the build status
[15:05:09.161] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:09.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:29:0) after 1m0s
[15:06:09.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:29:0)
[15:06:09.207] Timer tick, asking Buildbucket for the build status
[15:06:09.307] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:09.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:30:0) after 1m0s
[15:07:09.332] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:30:0)
[15:07:09.332] Timer tick, asking Buildbucket for the build status
[15:07:09.428] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:09.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:31:0) after 1m0s
[15:08:09.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:31:0)
[15:08:09.496] Timer tick, asking Buildbucket for the build status
[15:08:09.616] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:09.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:32:0) after 1m0s
[15:09:09.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:32:0)
[15:09:09.660] Timer tick, asking Buildbucket for the build status
[15:09:09.767] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:09.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:33:0) after 1m0s
[15:10:09.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:33:0)
[15:10:09.836] Timer tick, asking Buildbucket for the build status
[15:10:09.910] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:09.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:34:0) after 1m0s
[15:11:09.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:34:0)
[15:11:09.949] Timer tick, asking Buildbucket for the build status
[15:11:10.014] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:10.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:35:0) after 1m0s
[15:12:10.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:35:0)
[15:12:10.011] Timer tick, asking Buildbucket for the build status
[15:12:10.200] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:10.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:36:0) after 1m0s
[15:13:10.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:36:0)
[15:13:10.223] Timer tick, asking Buildbucket for the build status
[15:13:10.321] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:10.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:37:0) after 1m0s
[15:14:10.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:37:0)
[15:14:10.347] Timer tick, asking Buildbucket for the build status
[15:14:10.422] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:10.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:38:0) after 1m0s
[15:15:10.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:38:0)
[15:15:10.913] Timer tick, asking Buildbucket for the build status
[15:15:11.002] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:11.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:39:0) after 1m0s
[15:16:11.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:39:0)
[15:16:11.175] Timer tick, asking Buildbucket for the build status
[15:16:11.254] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:11.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:40:0) after 1m0s
[15:17:11.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:40:0)
[15:17:11.449] Timer tick, asking Buildbucket for the build status
[15:17:11.520] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:11.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:41:0) after 1m0s
[15:18:11.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:41:0)
[15:18:11.607] Timer tick, asking Buildbucket for the build status
[15:18:11.687] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:11.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:42:0) after 1m0s
[15:19:11.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:42:0)
[15:19:11.786] Timer tick, asking Buildbucket for the build status
[15:19:11.887] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:11.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:43:0) after 1m0s
[15:20:11.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:43:0)
[15:20:11.928] Timer tick, asking Buildbucket for the build status
[15:20:11.997] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:11.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:44:0) after 1m0s
[15:21:12.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:44:0)
[15:21:12.075] Timer tick, asking Buildbucket for the build status
[15:21:12.170] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:12.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:45:0) after 1m0s
[15:22:12.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:45:0)
[15:22:12.259] Timer tick, asking Buildbucket for the build status
[15:22:12.787] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:12.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:46:0) after 1m0s
[15:23:12.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:46:0)
[15:23:12.819] Timer tick, asking Buildbucket for the build status
[15:23:17.063] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:17.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:47:0) after 1m0s
[15:24:17.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:47:0)
[15:24:17.136] Timer tick, asking Buildbucket for the build status
[15:24:17.217] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:17.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:48:0) after 1m0s
[15:25:17.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:48:0)
[15:25:17.244] Timer tick, asking Buildbucket for the build status
[15:25:17.409] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:17.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:49:0) after 1m0s
[15:26:17.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:49:0)
[15:26:17.507] Timer tick, asking Buildbucket for the build status
[15:26:17.593] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:17.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:50:0) after 1m0s
[15:27:17.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:50:0)
[15:27:17.666] Timer tick, asking Buildbucket for the build status
[15:27:17.751] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:17.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:51:0) after 1m0s
[15:28:17.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:51:0)
[15:28:17.759] Timer tick, asking Buildbucket for the build status
[15:28:17.863] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:17.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:52:0) after 1m0s
[15:29:17.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:52:0)
[15:29:17.880] Timer tick, asking Buildbucket for the build status
[15:29:18.063] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:18.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:53:0) after 1m0s
[15:30:18.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:53:0)
[15:30:18.089] Timer tick, asking Buildbucket for the build status
[15:30:18.333] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:18.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:54:0) after 1m0s
[15:31:18.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:54:0)
[15:31:18.401] Timer tick, asking Buildbucket for the build status
[15:31:18.528] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:55:0) after 1m0s
[15:32:18.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:55:0)
[15:32:18.548] Timer tick, asking Buildbucket for the build status
[15:32:18.791] Build 8852503349107646080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017933411094963712:56:0) after 1m0s
[15:32:46.077] Received PubSub notification, asking Buildbucket for the build status
[15:32:46.166] Build 8852503349107646080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:32:46.166] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615995164406420",
"created_by": "project:chromium",
"created_ts": "1615991942263303",
"id": "8852503349107646080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82b43210b6a7221dcca80749a4c4db14d5c7a214\"}}",
"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\": \"82b43210b6a7221dcca80749a4c4db14d5c7a214\", \"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-19-2gyw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181456, \"got_angle_revision\": \"b3394db36779b618b824d91f52cfd3dc3136c21f\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"82b43210b6a7221dcca80749a4c4db14d5c7a214\", \"got_revision_cp\": \"refs/heads/master@{#863752}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"07c60e0c75db7c20980bbc2aa51f3468985a60da\", \"got_v8_revision_cp\": \"refs/heads/9.1.142@{#1}\", \"got_webrtc_revision\": \"ab6335041130fdc0365a604f49668eac9194f9d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33479}\", \"is_cached\": true, \"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\": \"82b43210b6a7221dcca80749a4c4db14d5c7a214\", \"swarm_hashes_refs/heads/master(at){#863752}_without_patch\": {\"absl_hardening_tests\": \"40a10f8441c4b3ec6c66b83c72ef652e09a4f0a7\", \"accessibility_unittests\": \"cd248e4699137698326b717744cfec1b4d452fc2\", \"angle_unittests\": \"09163b999aa9a70faa37e40331e4da457023c7e9\", \"app_shell_unittests\": \"3c11413f077835909aa2d2b92dcd62abc6e1941c\", \"aura_unittests\": \"8801a63da1d962ce2b1cae443b18dcb0f74d621c\", \"base_unittests\": \"9f52d0846d3e32792c03855940883b50c0ab1e53\", \"base_util_unittests\": \"d6316dd2c6eaa2aa50a25e5a11e7f7f71b25c731\", \"blink_common_unittests\": \"4032d50449fb7ed01acee18b51b3dd6d23a89107\", \"blink_fuzzer_unittests\": \"3af6adb9c0fab9d737ccf9986d37900ca1d9e241\", \"blink_heap_unittests\": \"cf484e506fdf87ca4df6d5a467c202f5d862e2dc\", \"blink_platform_unittests\": \"2a06fdd49376edf998962413454a5dc9ec1d9fc1\", \"blink_python_tests\": \"67a41ac2a8b197d000d66c8e89e12fc53cffd758\", \"blink_unittests\": \"090ec7f14d762b92c76fc880f9e3ba11a43253e1\", \"blink_web_tests\": \"eaeef3955785d732875ce68225f2a49e33d28338\", \"boringssl_crypto_tests\": \"a13ce89bb8a01c23145353f3a717cadcb898898d\", \"boringssl_ssl_tests\": \"e9d1bacf700ad95da417845fd28bd2699b43668a\", \"browser_tests\": \"d0c2eead09171028cdd50cf6cafb328fdacc9236\", \"capture_unittests\": \"3834bc371199feb5f612e7f6c0bc84ce5fea438f\", \"cast_unittests\": \"abee174ab187356fe1218f245409cf1ea57e97de\", \"cc_unittests\": \"e65fffd2ae26d4e269fead7c4a94ec46005878d1\", \"chrome_app_unittests\": \"35412e160ab204d23dd249e6c9f460d9bf030914\", \"chromedriver_unittests\": \"9feed0c3a0a3979d842f1f60bae434d96279d08e\", \"color_unittests\": \"d452dea16e00aa29a246126dcf1b376eb12d6e1c\", \"components_browsertests\": \"8404ae7f02e36ac5109a7e427aa1c04bbb81502b\", \"components_unittests\": \"b7e8e5898ce87d339a920794250d8d336c942194\", \"compositor_unittests\": \"cfe5de763850e6d74f5cedfed024ab6027b87503\", \"content_browsertests\": \"1c2a598510e272a2ef34dc50a49005a67d108679\", \"content_shell_crash_test\": \"2148a80c0d7357bfcf4844e9b47dda4525a5623c\", \"content_unittests\": \"3a6bdf002369c840efb4cc94a223fb5df74282b1\", \"crashpad_tests\": \"6593a567e42e8d94d43db310db2003aad9bdbc7a\", \"cronet_tests\": \"45612136c8557163ded966b601ee90300bd53fdb\", \"cronet_unittests\": \"3b2c8198f6efe58fdfd9ca38ddcee3b562fdae44\", \"crypto_unittests\": \"480424a1c1216c34818a0db257f908dddff67e6f\", \"dbus_unittests\": \"eb62de77f090d729e3084a5fef5bc36714d4b2ed\", \"device_unittests\": \"635a4506a09b669442a8240f9f54173b707b214b\", \"display_unittests\": \"4e5283943233dd5cdb33a56dfca4cacd60732c77\", \"events_unittests\": \"7170d28586be467527f1b32d824d5e43a5df283f\", \"extensions_browsertests\": \"b3a4f1f7fb9fb02fb31b8f7e95746d7fdb64575a\", \"extensions_unittests\": \"827c8451a9469435822ed1b7cc5ca093c03fbe4d\", \"filesystem_service_unittests\": \"f404de52ac42f3da0f89eec2040b04a597a972c5\", \"flatbuffers_unittests\": \"33ce473c25487fefac09ff9e3c5c615fa4ca6686\", \"gcm_unit_tests\": \"c9fd0bc2d258ffd73ae9b8c93baf76d428c30cca\", \"gfx_unittests\": \"66cd4ab924d0565b2da83127b9c8b237fc721142\", \"gin_unittests\": \"cdd0fe630110ff1ac7eb94be104dc773b3670e4c\", \"google_apis_unittests\": \"fe36dfdd4928a6cfef989616a3b1eb1ea6a4e9fd\", \"gpu_unittests\": \"5b490e676dc9666b3815b3b53a397ba9ef8eba60\", \"grit_python_unittests\": \"a6a82a347c5ac19643f71ece0eaa364aa5fca490\", \"gwp_asan_unittests\": \"75673b563709de81fcf5e5e560703ea790e92956\", \"headless_browsertests\": \"e7b0b20cd4a182d7b908515d62058bfaf9590832\", \"headless_unittests\": \"111e5a563e7f61e5e39c1e30b96fc6d00bd5bad5\", \"interactive_ui_tests\": \"7de73ac7e298c4fe72cf0137d047f062bf002f95\", \"ipc_tests\": \"ed5f181f2951ad43537cd3d25f7c95230c354057\", \"jingle_unittests\": \"bdea28173d2a854892c934b30596e47e5c88e046\", \"latency_unittests\": \"402059736c440fc76684bb149cad0225506d69be\", \"libjingle_xmpp_unittests\": \"cbc9974a9816073279120e91397cdb9cf6dea2a0\", \"liburlpattern_unittests\": \"52a878b4348d8e1127034c0ae33fb35773f60b1f\", \"media_blink_unittests\": \"45c0d400b6f5efcfd4a37628b6c51a1b41583f56\", \"media_unittests\": \"51fdf77d96f4b02cb54401b27934c1ee57342a85\", \"message_center_unittests\": \"c5e265f83a63bcb42fcc53449da421e7c56b52a4\", \"metrics_python_tests\": \"f71dfe6682347a37575ea3f990280cd0738da40f\", \"midi_unittests\": \"03ebd53f5100c18cd45f22634674df230e41556b\", \"mojo_core_unittests\": \"4d5a8cc25e3fe5ffce48950ffdad6d66f2316875\", \"mojo_unittests\": \"f2090b2cf3454c3bfbe4562e410f2cf2ed16ffcf\", \"nacl_helper_nonsfi_unittests\": \"faf283551ad721783ebea0f1ba01c332e1f7a4f0\", \"nacl_loader_unittests\": \"50e4ab96c767cfbf53e38373a44161321d81d6d1\", \"native_theme_unittests\": \"367fb6e88f02fd92723e0b73a62c361d1796a3df\", \"net_unittests\": \"864e347db8dd076fcfc163ae28f948b8d9c0f9ce\", \"openscreen_unittests\": \"1b47c1fc89c310112bc0f4092aacb080a84488d8\", \"pdf_unittests\": \"73db10e23a5f0f88b16667bbdae356ac2322c5b0\", \"perfetto_unittests\": \"2cd0ed2d15957a9a402ba0378e50cec21980b165\", \"ppapi_unittests\": \"b5d30c961940707a7f18c7d051606077b535a00d\", \"printing_unittests\": \"1e900ce40e914d85e19322f9a767d0275f137104\", \"remoting_unittests\": \"56dccd90e6f0508975cb9c04da55c64aaee9e1ab\", \"sandbox_linux_unittests\": \"7d6a3e848ac9779f6e7bf2f922dc9b9c91822107\", \"service_manager_unittests\": \"ee6de705e785cf19fe675434e888571bb706cad6\", \"services_unittests\": \"11f45adf9b5675a4b36d9e83ba7580f9f5708395\", \"shell_dialogs_unittests\": \"4ff2e1909bd49d25a2650ce7ba5076652813145b\", \"skia_unittests\": \"d522c0b6d461acbc9bce589b9180354a47174333\", \"snapshot_unittests\": \"29ef8f1b36cb5c1a5958fd8ad213ba7a82d5d718\", \"sql_unittests\": \"a989312dfc0075903c97e45ff9905a557ae05090\", \"storage_unittests\": \"7db09e73bd5af6f7732a3c6d33b22ba232c8bb7f\", \"sync_integration_tests\": \"4876f0f3a32195774a2a42b2693a1c2cd79f2a99\", \"telemetry_gpu_unittests\": \"fd0b5e6bf956e82fbd57988b16eddb002003ddc1\", \"telemetry_perf_unittests\": \"9deb74f461cf41535799a702d748a88db9fb7afa\", \"telemetry_unittests\": \"ceb169aabb819e86f52c97a3953a55b8c6238b30\", \"traffic_annotation_auditor_unittests\": \"1e2d4274a2651ea8202ada3ee04bb56d641224ec\", \"ui_base_unittests\": \"b1d58d25ba59f9def1c950edae985d5d92ea710c\", \"ui_touch_selection_unittests\": \"5c0c10af1876a7bf60afa07a7a2694629f476ab1\", \"unit_tests\": \"c045bfad40f28eed1175a404ce49679639867899\", \"url_unittests\": \"49e09920dc5f50f7ed7de3b2c8fe1f45dfc792c7\", \"views_perftests\": \"bde12fc0d770914ba741d6ea76e5d31eeaa3f4c1\", \"views_unittests\": \"bae89748bd8252a6595490ed92e7863d9a5fd7ed\", \"viz_unittests\": \"2aa6edafb75a6d58fa69072715a109b2f474998e\", \"vr_common_unittests\": \"f33329bd647521d4aa153c80512a3528a0cc342f\", \"vr_pixeltests\": \"ef006d08b84b4482fbd1f866295a4d41464dec4a\", \"webdriver_wpt_tests\": \"546bc8ad83b481bd150e4065b1089845e8772127\", \"weblayer_browsertests\": \"a2bf8cb6522b808310583ce64ca6876b36923c3f\", \"weblayer_unittests\": \"d88dc00bdbf7ab814035ff2a83274479c3d600da\", \"wm_unittests\": \"904aceae8f25ae68f65ef9295edf9611a5549a3e\", \"wtf_unittests\": \"ce7d7f08b7915b080eea2800279421c3eeaede6f\", \"x11_unittests\": \"1097b32f3ecb7c61a42faa0df47e052f6e93116d\", \"xr_browser_tests\": \"97be30899b801fe7c393c8e5ccd0fb59dce29b95\", \"zlib_unittests\": \"aaa6e594896bdbf191bffeafc8cbc679bab8ff3c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_53a369b6e7b3f2409540d71b27a68c8bcf1cb73633e70dba0b4b8b173a0aec5e_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_d4fdaf58b7947408531076283e0e8baf90c29d26a4447be7804b77c871ea449a_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_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-19-2gyw\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615991964054688",
"status": "COMPLETED",
"status_changed_ts": "1615995164625866",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181456",
"builder:Linux Builder (dbg)",
"buildset:commit/git/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b43210b6a7221dcca80749a4c4db14d5c7a214",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017933411094963712",
"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/8852503349107646080/+/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:525971bc117d8510",
"user_agent:luci-scheduler"
],
"updated_ts": "1615995164630084",
"url": "https://ci.chromium.org/b/8852503349107646080",
"utcnow_ts": "1615995166158996"
}
}
[15:32:46.166] Invocation finished in 53m45.181723173s with status SUCCEEDED