[18:09:44.174] New invocation is queued and will start shortly
[18:09:45.323] Starting the invocation (attempt 1)
[18:09:45.371] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:09:45.371] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:09:45.371] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027251641315368944",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"89ece72e200fd9d2d2b27e96a35303dfcec455ad\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9027251641315368944",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"gitiles_ref:refs/heads/master"
]
}
[18:09:46.254] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607105385460046",
"id": "8861821579293752256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"89ece72e200fd9d2d2b27e96a35303dfcec455ad\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607105386101631",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178347",
"builder:Linux Builder (dbg)",
"buildset:commit/git/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027251641315368944",
"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/8861821579293752256/+/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": "1607105386101743",
"url": "https://ci.chromium.org/b/8861821579293752256",
"utcnow_ts": "1607105386238663"
}
}
[18:09:46.254] Task URL: https://ci.chromium.org/b/8861821579293752256
[18:09:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:2:0) after 1m0s
[18:10:01.229] Received PubSub notification, asking Buildbucket for the build status
[18:10:01.372] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:46.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:2:0)
[18:10:46.878] Timer tick, asking Buildbucket for the build status
[18:10:47.012] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:47.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:4:0) after 1m0s
[18:11:47.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:4:0)
[18:11:47.320] Timer tick, asking Buildbucket for the build status
[18:11:47.421] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:47.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:5:0) after 1m0s
[18:12:47.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:5:0)
[18:12:47.591] Timer tick, asking Buildbucket for the build status
[18:12:47.742] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:47.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:6:0) after 1m0s
[18:13:47.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:6:0)
[18:13:47.818] Timer tick, asking Buildbucket for the build status
[18:13:48.232] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:48.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:7:0) after 1m0s
[18:14:48.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:7:0)
[18:14:48.383] Timer tick, asking Buildbucket for the build status
[18:14:48.509] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:48.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:8:0) after 1m0s
[18:15:48.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:8:0)
[18:15:48.770] Timer tick, asking Buildbucket for the build status
[18:15:49.473] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:49.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:9:0) after 1m0s
[18:16:49.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:9:0)
[18:16:49.691] Timer tick, asking Buildbucket for the build status
[18:16:49.954] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:49.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:10:0) after 1m0s
[18:17:50.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:10:0)
[18:17:50.129] Timer tick, asking Buildbucket for the build status
[18:17:50.199] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:50.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:11:0) after 1m0s
[18:18:50.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:11:0)
[18:18:50.327] Timer tick, asking Buildbucket for the build status
[18:18:50.460] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:50.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:12:0) after 1m0s
[18:19:50.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:12:0)
[18:19:50.569] Timer tick, asking Buildbucket for the build status
[18:19:50.894] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:50.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:13:0) after 1m0s
[18:20:50.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:13:0)
[18:20:50.877] Timer tick, asking Buildbucket for the build status
[18:20:51.100] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:51.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:14:0) after 1m0s
[18:21:51.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:14:0)
[18:21:51.121] Timer tick, asking Buildbucket for the build status
[18:21:51.189] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:51.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:15:0) after 1m0s
[18:22:51.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:15:0)
[18:22:51.221] Timer tick, asking Buildbucket for the build status
[18:22:51.999] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:51.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:16:0) after 1m0s
[18:23:52.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:16:0)
[18:23:52.142] Timer tick, asking Buildbucket for the build status
[18:23:52.628] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:52.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:17:0) after 1m0s
[18:24:52.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:17:0)
[18:24:52.763] Timer tick, asking Buildbucket for the build status
[18:24:52.898] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:52.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:18:0) after 1m0s
[18:25:53.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:18:0)
[18:25:53.001] Timer tick, asking Buildbucket for the build status
[18:25:53.120] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:53.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:19:0) after 1m0s
[18:26:53.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:19:0)
[18:26:53.180] Timer tick, asking Buildbucket for the build status
[18:26:53.274] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:53.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:20:0) after 1m0s
[18:27:53.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:20:0)
[18:27:53.266] Timer tick, asking Buildbucket for the build status
[18:27:53.328] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:53.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:21:0) after 1m0s
[18:28:53.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:21:0)
[18:28:53.409] Timer tick, asking Buildbucket for the build status
[18:28:53.474] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:53.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:22:0) after 1m0s
[18:29:53.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:22:0)
[18:29:53.529] Timer tick, asking Buildbucket for the build status
[18:29:53.653] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:53.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:23:0) after 1m0s
[18:30:53.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:23:0)
[18:30:53.735] Timer tick, asking Buildbucket for the build status
[18:30:53.870] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:53.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:24:0) after 1m0s
[18:31:53.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:24:0)
[18:31:53.939] Timer tick, asking Buildbucket for the build status
[18:31:54.056] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:54.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:25:0) after 1m0s
[18:32:54.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:25:0)
[18:32:54.122] Timer tick, asking Buildbucket for the build status
[18:32:54.514] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:54.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:26:0) after 1m0s
[18:33:54.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:26:0)
[18:33:54.532] Timer tick, asking Buildbucket for the build status
[18:33:54.622] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:54.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:27:0) after 1m0s
[18:34:54.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:27:0)
[18:34:54.664] Timer tick, asking Buildbucket for the build status
[18:34:55.106] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:55.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:28:0) after 1m0s
[18:35:55.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:28:0)
[18:35:55.182] Timer tick, asking Buildbucket for the build status
[18:35:55.317] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:55.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:29:0) after 1m0s
[18:36:55.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:29:0)
[18:36:55.388] Timer tick, asking Buildbucket for the build status
[18:36:55.725] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:55.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:30:0) after 1m0s
[18:37:56.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:30:0)
[18:37:56.035] Timer tick, asking Buildbucket for the build status
[18:37:56.122] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:56.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:31:0) after 1m0s
[18:38:58.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:31:0)
[18:38:58.082] Timer tick, asking Buildbucket for the build status
[18:38:58.271] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:32:0) after 1m0s
[18:39:58.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:32:0)
[18:39:58.326] Timer tick, asking Buildbucket for the build status
[18:39:58.438] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:58.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:33:0) after 1m0s
[18:40:58.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:33:0)
[18:40:58.520] Timer tick, asking Buildbucket for the build status
[18:40:58.717] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:58.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:34:0) after 1m0s
[18:41:58.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:34:0)
[18:41:58.775] Timer tick, asking Buildbucket for the build status
[18:41:58.832] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:58.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:35:0) after 1m0s
[18:42:58.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:35:0)
[18:42:58.871] Timer tick, asking Buildbucket for the build status
[18:42:58.935] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:58.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:36:0) after 1m0s
[18:43:58.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:36:0)
[18:43:58.962] Timer tick, asking Buildbucket for the build status
[18:43:59.015] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:59.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:37:0) after 1m0s
[18:44:59.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:37:0)
[18:44:59.022] Timer tick, asking Buildbucket for the build status
[18:44:59.113] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:59.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:38:0) after 1m0s
[18:46:00.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:38:0)
[18:46:00.021] Timer tick, asking Buildbucket for the build status
[18:46:00.295] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:00.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:39:0) after 1m0s
[18:47:00.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:39:0)
[18:47:00.417] Timer tick, asking Buildbucket for the build status
[18:47:00.533] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:00.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:40:0) after 1m0s
[18:48:02.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:40:0)
[18:48:02.036] Timer tick, asking Buildbucket for the build status
[18:48:04.561] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:04.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:41:0) after 1m0s
[18:49:04.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:41:0)
[18:49:04.710] Timer tick, asking Buildbucket for the build status
[18:49:04.881] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:04.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:42:0) after 1m0s
[18:50:05.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:42:0)
[18:50:05.118] Timer tick, asking Buildbucket for the build status
[18:50:05.308] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:05.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:43:0) after 1m0s
[18:51:05.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:43:0)
[18:51:05.718] Timer tick, asking Buildbucket for the build status
[18:51:05.892] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:05.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:44:0) after 1m0s
[18:52:05.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:44:0)
[18:52:05.991] Timer tick, asking Buildbucket for the build status
[18:52:06.102] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:06.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:45:0) after 1m0s
[18:53:06.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:45:0)
[18:53:06.231] Timer tick, asking Buildbucket for the build status
[18:53:06.377] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:06.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:46:0) after 1m0s
[18:54:06.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:46:0)
[18:54:06.463] Timer tick, asking Buildbucket for the build status
[18:54:06.529] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:06.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:47:0) after 1m0s
[18:55:06.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:47:0)
[18:55:06.678] Timer tick, asking Buildbucket for the build status
[18:55:06.818] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:06.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:48:0) after 1m0s
[18:56:06.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:48:0)
[18:56:06.965] Timer tick, asking Buildbucket for the build status
[18:56:07.062] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:07.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:49:0) after 1m0s
[18:57:07.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:49:0)
[18:57:07.296] Timer tick, asking Buildbucket for the build status
[18:57:07.357] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:07.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:50:0) after 1m0s
[18:58:07.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:50:0)
[18:58:07.642] Timer tick, asking Buildbucket for the build status
[18:58:07.740] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:07.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:51:0) after 1m0s
[18:59:08.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:51:0)
[18:59:08.471] Timer tick, asking Buildbucket for the build status
[18:59:08.568] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:08.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:52:0) after 1m0s
[19:00:08.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:52:0)
[19:00:08.691] Timer tick, asking Buildbucket for the build status
[19:00:09.070] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:09.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:53:0) after 1m0s
[19:01:09.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:53:0)
[19:01:09.435] Timer tick, asking Buildbucket for the build status
[19:01:09.603] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:09.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:54:0) after 1m0s
[19:02:09.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:54:0)
[19:02:09.638] Timer tick, asking Buildbucket for the build status
[19:02:09.745] Build 8861821579293752256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:09.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027251641315368944:55:0) after 1m0s
[19:02:58.313] Received PubSub notification, asking Buildbucket for the build status
[19:02:58.732] Build 8861821579293752256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:02:58.732] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607108576756860",
"created_by": "project:chromium",
"created_ts": "1607105385460046",
"id": "8861821579293752256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"89ece72e200fd9d2d2b27e96a35303dfcec455ad\"}}",
"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\": \"89ece72e200fd9d2d2b27e96a35303dfcec455ad\", \"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-0-cooa\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178347, \"got_angle_revision\": \"1ad5791d97bea23f092b206679a56302defa378f\", \"got_dawn_revision\": \"ab5821d0166feabf7690b7d2399ad36870501e72\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"89ece72e200fd9d2d2b27e96a35303dfcec455ad\", \"got_revision_cp\": \"refs/heads/master@{#833768}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"ad70609509a98138cd6391828e4adafeb2f35b3d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32771}\", \"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\": \"89ece72e200fd9d2d2b27e96a35303dfcec455ad\", \"swarm_hashes_refs/heads/master(at){#833768}_without_patch\": {\"absl_hardening_tests\": \"0a4519df8934417010cf018194b441b6c53df1be\", \"accessibility_unittests\": \"678a3574b7ff8011846879400e14d3fc1116263d\", \"angle_unittests\": \"66263ed5712c83d919a5ebde675886f82a3a1a11\", \"app_shell_unittests\": \"9c06f73da22da2b8a08adcc7b014cf0fab4ce4d5\", \"aura_unittests\": \"b3ae300e44ea4c06005452f2ca4d41fc429748d3\", \"base_unittests\": \"a9554d2a089486cd4c462a3cb799fe7f9728c135\", \"base_util_unittests\": \"a3362fc4122b002d2dacc138bd13c6533431211f\", \"blink_common_unittests\": \"c2151a499ab6664c52d7c5655c4e251d7a520aff\", \"blink_fuzzer_unittests\": \"13edd11899e175481697ad6afb161b0caa973cb5\", \"blink_heap_unittests\": \"88c2a73ff52ef93a354c7b898122c7e12fe3d57f\", \"blink_platform_unittests\": \"be5b0b63353890869c2c7226d821df6a88f690dd\", \"blink_python_tests\": \"228f1f1ee44cb247ff28033e1339052aea8ba0c9\", \"blink_unittests\": \"91a33f0dd2e2bf17fa5da0de9fafdee6cea9b106\", \"blink_web_tests\": \"df094b7fa5404b4c60f1be5dcd670b5674bfb89f\", \"boringssl_crypto_tests\": \"54adb277ed44410fd74a142942d5b1c2d4b7f30c\", \"boringssl_ssl_tests\": \"cee3514dd5f20bb68fc9bab1552fbdcb141d52b6\", \"browser_tests\": \"a30f08728fc1215b81b8b42c3d422b17c72afa11\", \"capture_unittests\": \"a12bea505859dd64c5cfc8a1b05f561fec9d5103\", \"cast_unittests\": \"62114c883e6cd87d0982df6a5da27005ff265017\", \"cc_unittests\": \"e4f312f2eb8d4785c61f5f7a7d7ee92cbe330da6\", \"chrome_app_unittests\": \"d18fe41e1b12bebb1145e589fbdd2fcee0263d76\", \"chromedriver_unittests\": \"4b20e7e004a3832e97281a9ba6a7134d162ceefd\", \"components_browsertests\": \"f44d00aa2e68ba3a681bab403776fd4f88f9773d\", \"components_unittests\": \"a57ecb976d9ddf81c92fbba605b783810f367357\", \"compositor_unittests\": \"63a550276e7b410d1344262e8b35a7d9db08925b\", \"content_browsertests\": \"f7f2f55ac7c092ac5ee815610217c7dcd9f3ca8a\", \"content_shell_crash_test\": \"5fb1dc190fa917f7c48b6cafccad73b59d4b64dc\", \"content_unittests\": \"1e1510019e1c009179a86af3363acdb720e9936e\", \"crashpad_tests\": \"03407dca38465ebb6c215cd33fbc70577f7ea3cd\", \"cronet_tests\": \"9e652d5602a3ca01419450a84b6603ab6bb9f755\", \"cronet_unittests\": \"666b8feed3e136612bcbd4575b92f6ad97deae38\", \"crypto_unittests\": \"f3f9e5705a85fdaa7852dfc1981bc9ae60a4c05b\", \"dbus_unittests\": \"1f638ffac2e0748f882e2522f41da2996b00e457\", \"device_unittests\": \"9c04114bf12e059458ae23b3634bf99f5900b069\", \"display_unittests\": \"1a091a7032cabe3d9995cf5a4287d9a8217e3d8e\", \"events_unittests\": \"72ee79aa45d0cb340bac8e717c65d61a94a1afaf\", \"extension_docserver_python_unittests\": \"815409a7f5d4837988aa936f31d4c88c2ef41d78\", \"extensions_browsertests\": \"777713b56da9f3735ed44f3bb502709e6d35737b\", \"extensions_unittests\": \"5f93956f73f73c829041ad1fe077b5cb178f6a61\", \"filesystem_service_unittests\": \"1b43e1ee9bcd961d8be0e0cde689066ad18c320b\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"0c59834c5a7a9c56aac575c99e42e46f771b4852\", \"gfx_unittests\": \"7723e2bbcaabd26eeca63e97e1a696c695b31506\", \"gin_unittests\": \"b3bc695ab74b7c674dd5bab6cfefecaa34ca4dd4\", \"google_apis_unittests\": \"90b089093cd68820aa904e9bec05903d68ee54ae\", \"gpu_unittests\": \"9edd8264f01008a07b48a7bd51df904a86e89215\", \"grit_python_unittests\": \"1664d3ab1c9a0d4f1b2faad9f251fabed51abe36\", \"gwp_asan_unittests\": \"06d98bcd5f08b075d79c8398836edde5278287d5\", \"headless_browsertests\": \"6aa2e182c42dd5db88e988c97cf239fef7eb6cb0\", \"headless_unittests\": \"14a8bcb1476de9081e79f24e768e77a93f58d1a1\", \"interactive_ui_tests\": \"d7523e6e309f1c3024538955b6df20331400e1cd\", \"ipc_tests\": \"e399c96b476d4145e29be0b5b9c739da060ec19b\", \"jingle_unittests\": \"7d7e7e89bb345f0080c9f5562f3cc38258c4e95c\", \"latency_unittests\": \"9dc4fc6365a2719d712b3e4986dd5fb87501b0db\", \"libjingle_xmpp_unittests\": \"b3c89431bd217cdcf956b56c34fd77aff03c3029\", \"liburlpattern_unittests\": \"ab522eea4992272b63b9d4f816c45f420c11ea86\", \"media_blink_unittests\": \"6b83112da7cffc147ca5fa46f7381aabfc5e170c\", \"media_unittests\": \"444a777b0cfe43d30d412e209c8df7dad6dfb62c\", \"message_center_unittests\": \"e6ecb80e51c36bc0064c62708a5bbd9019db1689\", \"metrics_python_tests\": \"ef13755544eba743ddc9e6cafaed244f112b97bd\", \"midi_unittests\": \"9acc68b624f7f9e40cac9cb911ac71e06d013d29\", \"mojo_core_unittests\": \"a54a05e9197b3737a9af94d266ea35ac601c2576\", \"mojo_unittests\": \"bd51bf82f097bb7f9f99cd6e2ab4707efce29de6\", \"nacl_helper_nonsfi_unittests\": \"edfb98901353ee53224efe436365e7165cb4fc40\", \"nacl_loader_unittests\": \"f4ff604f2dcea28363b04eb22fd3ca3e1ded29ed\", \"native_theme_unittests\": \"7c6cfb974ea5eb34f0ffc1757ba0c6d3cafd711a\", \"net_unittests\": \"728f5a7e9678e66f94176e05e304466d587dd77a\", \"openscreen_unittests\": \"db9acb91d3d400bf4c334c91d26467886a8b7563\", \"pdf_unittests\": \"3e284ef428fb48ac2ea6242c1b5c04c7503c7dcd\", \"perfetto_unittests\": \"0717d834893ebcf6b8dea80b098c06383ee8766c\", \"ppapi_unittests\": \"cc2c77e32bea0872b32e6a83877196678d632c08\", \"printing_unittests\": \"12919e65be7a48402a93276d23e7de7515369112\", \"remoting_unittests\": \"a59ebbfba29637985f83c5063419386729ca563b\", \"sandbox_linux_unittests\": \"ee3a2807f54fd81947bd5d00601b520ca1b13ffb\", \"service_manager_unittests\": \"83ddabeaa117d1652a1c4cac99c3e938c995a003\", \"services_unittests\": \"0d91e9b3b1ddad3c6a1c20efa7ee0a4b198cf795\", \"shell_dialogs_unittests\": \"6331d4ece19c42d8b685d82593775571d2f87720\", \"skia_unittests\": \"1001ac1787e5273cabf90af956e11dad64158cd1\", \"snapshot_unittests\": \"39a5be04a71545fabbeb31031a5995e55da64759\", \"sql_unittests\": \"962a1638590b4789f6cbec86534c0b87d7178154\", \"storage_unittests\": \"b6208a7d03fed9cb80f51ba398a54f4a99168796\", \"sync_integration_tests\": \"ec4e817b807b56ebd13ae8bfeaa00ec96a70031f\", \"telemetry_gpu_unittests\": \"4425563dfc9c28dc84bcf999d05fbd19154ca7ee\", \"telemetry_perf_unittests\": \"cbfeda10b6a534f4b2e3e1905efc1271af2b079e\", \"telemetry_unittests\": \"2f49732e4e6723e950f4ec56b5abcb6fbe9d4085\", \"traffic_annotation_auditor_unittests\": \"b69ad41c9275570b97dad5e0a29c2ddec890921c\", \"ui_base_unittests\": \"67374cc96d10e8a8b20f046e187cdc6c4177cecc\", \"ui_touch_selection_unittests\": \"3e822d7616d9927eb24427690f5c43a7ff48ff36\", \"unit_tests\": \"524f0a47fb83a3ea420e270203e4b287c4ac1e7c\", \"url_unittests\": \"021f480f54dd831bf4473302053ee0121e16c83f\", \"views_perftests\": \"a72031d1d0cf8843f0e5cba63221801a1e336b8c\", \"views_unittests\": \"65d0b42c5b2f1cdb8876d56e01ba62343f6f2c56\", \"viz_unittests\": \"24bcfa35a3ade825e4dc8f34d54eb2eb8fbbcc8b\", \"vr_common_unittests\": \"86811f1e45dff00c6e2c7b36bd38caee2520ac8f\", \"vr_pixeltests\": \"165602cce67b779c2930d1ab14a68126fd4099e6\", \"webdriver_wpt_tests\": \"ecbc23d3723fe727bdd792e52c39a2cc26aa6dba\", \"weblayer_browsertests\": \"70d98d3abc2426ef2311e4e36b243498402cbbf1\", \"weblayer_unittests\": \"436a5954bf310ff8ba5b1ed4099117a4ac16c0ca\", \"wm_unittests\": \"6a2f1f6755a13957df88ca457ad3512fd2b5f159\", \"wtf_unittests\": \"380e3121b8b47bee56723846e0fc041398e37a45\", \"x11_unittests\": \"06cd77ce9de26533b0a69897520af19ef8e0d8dd\", \"xr_browser_tests\": \"3dd349717295f4c3c3bfd4231eaf418ed5ab778d\", \"zlib_unittests\": \"994059ad273d6d67d481f66b444a1020e49852c6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_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-0-cooa\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607105400321803",
"status": "COMPLETED",
"status_changed_ts": "1607108577315546",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178347",
"builder:Linux Builder (dbg)",
"buildset:commit/git/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89ece72e200fd9d2d2b27e96a35303dfcec455ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027251641315368944",
"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/8861821579293752256/+/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:5047c3a1755fa210",
"user_agent:luci-scheduler"
],
"updated_ts": "1607108577335107",
"url": "https://ci.chromium.org/b/8861821579293752256",
"utcnow_ts": "1607108578722070"
}
}
[19:02:58.732] Invocation finished in 53m14.582172308s with status SUCCEEDED