[04:39:48.797] New invocation is queued and will start shortly
[04:39:49.939] Starting the invocation (attempt 1)
[04:39:49.981] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:39:49.981] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:39:49.981] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052850941792475216",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef536f4dd9b25111fb00d86fa3cda443d9bd1952\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052850941792475216",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"gitiles_ref:refs/heads/master"
]
}
[04:39:50.885] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582691990174562",
"id": "8887420879669250720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef536f4dd9b25111fb00d86fa3cda443d9bd1952\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582691990714629",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169029",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052850941792475216",
"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/8887420879669250720/+/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": "1582691990714740",
"url": "https://ci.chromium.org/b/8887420879669250720",
"utcnow_ts": "1582691990867539"
}
}
[04:39:50.885] Task URL: https://ci.chromium.org/b/8887420879669250720
[04:39:50.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:2:0) after 1m0s
[04:40:51.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:2:0)
[04:40:51.179] Timer tick, asking Buildbucket for the build status
[04:40:51.309] Build 8887420879669250720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:51.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:3:0) after 1m0s
[04:41:51.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:3:0)
[04:41:51.437] Timer tick, asking Buildbucket for the build status
[04:41:51.531] Build 8887420879669250720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:51.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:4:0) after 1m0s
[04:42:51.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:4:0)
[04:42:51.564] Timer tick, asking Buildbucket for the build status
[04:42:53.376] Build 8887420879669250720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:5:0) after 1m0s
[04:43:53.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:5:0)
[04:43:53.428] Timer tick, asking Buildbucket for the build status
[04:43:53.696] Build 8887420879669250720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:53.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:6:0) after 1m0s
[04:44:42.311] Received PubSub notification, asking Buildbucket for the build status
[04:44:42.383] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:53.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:6:0)
[04:44:53.771] Timer tick, asking Buildbucket for the build status
[04:44:53.872] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:53.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:8:0) after 1m0s
[04:45:53.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:8:0)
[04:45:53.950] Timer tick, asking Buildbucket for the build status
[04:45:54.222] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:54.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:9:0) after 1m0s
[04:46:54.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:9:0)
[04:46:54.298] Timer tick, asking Buildbucket for the build status
[04:46:54.445] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:54.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:10:0) after 1m0s
[04:47:54.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:10:0)
[04:47:54.510] Timer tick, asking Buildbucket for the build status
[04:47:54.845] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:54.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:11:0) after 1m0s
[04:48:54.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:11:0)
[04:48:54.867] Timer tick, asking Buildbucket for the build status
[04:48:54.990] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:12:0) after 1m0s
[04:49:55.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:12:0)
[04:49:55.102] Timer tick, asking Buildbucket for the build status
[04:49:55.488] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:55.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:13:0) after 1m0s
[04:50:55.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:13:0)
[04:50:55.582] Timer tick, asking Buildbucket for the build status
[04:50:55.685] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:55.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:14:0) after 1m0s
[04:51:55.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:14:0)
[04:51:55.692] Timer tick, asking Buildbucket for the build status
[04:51:55.785] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:55.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:15:0) after 1m0s
[04:52:55.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:15:0)
[04:52:55.889] Timer tick, asking Buildbucket for the build status
[04:52:56.109] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:56.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:16:0) after 1m0s
[04:53:56.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:16:0)
[04:53:56.217] Timer tick, asking Buildbucket for the build status
[04:53:56.324] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:56.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:17:0) after 1m0s
[04:54:56.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:17:0)
[04:54:56.447] Timer tick, asking Buildbucket for the build status
[04:54:56.566] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:56.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:18:0) after 1m0s
[04:55:56.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:18:0)
[04:55:56.654] Timer tick, asking Buildbucket for the build status
[04:55:56.742] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:56.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:19:0) after 1m0s
[04:56:56.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:19:0)
[04:56:56.768] Timer tick, asking Buildbucket for the build status
[04:56:56.867] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:56.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:20:0) after 1m0s
[04:57:56.905] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:20:0)
[04:57:56.905] Timer tick, asking Buildbucket for the build status
[04:57:57.357] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:57.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:21:0) after 1m0s
[04:58:57.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:21:0)
[04:58:57.388] Timer tick, asking Buildbucket for the build status
[04:58:57.654] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:57.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:22:0) after 1m0s
[04:59:57.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:22:0)
[04:59:57.679] Timer tick, asking Buildbucket for the build status
[04:59:57.765] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:57.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:23:0) after 1m0s
[05:00:57.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:23:0)
[05:00:57.791] Timer tick, asking Buildbucket for the build status
[05:00:59.624] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:59.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:24:0) after 1m0s
[05:02:00.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:24:0)
[05:02:00.117] Timer tick, asking Buildbucket for the build status
[05:02:00.390] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:00.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:25:0) after 1m0s
[05:03:00.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:25:0)
[05:03:00.447] Timer tick, asking Buildbucket for the build status
[05:03:00.738] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:00.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:26:0) after 1m0s
[05:04:00.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:26:0)
[05:04:00.758] Timer tick, asking Buildbucket for the build status
[05:04:01.038] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:01.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:27:0) after 1m0s
[05:05:01.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:27:0)
[05:05:01.059] Timer tick, asking Buildbucket for the build status
[05:05:01.151] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:01.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:28:0) after 1m0s
[05:06:01.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:28:0)
[05:06:01.360] Timer tick, asking Buildbucket for the build status
[05:06:01.706] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:01.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:29:0) after 1m0s
[05:07:01.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:29:0)
[05:07:01.954] Timer tick, asking Buildbucket for the build status
[05:07:02.078] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:02.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:30:0) after 1m0s
[05:08:02.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:30:0)
[05:08:02.246] Timer tick, asking Buildbucket for the build status
[05:08:02.745] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:31:0) after 1m0s
[05:09:02.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:31:0)
[05:09:02.952] Timer tick, asking Buildbucket for the build status
[05:09:03.367] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:03.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:32:0) after 1m0s
[05:10:03.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:32:0)
[05:10:03.460] Timer tick, asking Buildbucket for the build status
[05:10:03.551] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:03.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:33:0) after 1m0s
[05:11:03.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:33:0)
[05:11:03.796] Timer tick, asking Buildbucket for the build status
[05:11:03.904] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:03.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:34:0) after 1m0s
[05:12:03.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:34:0)
[05:12:03.947] Timer tick, asking Buildbucket for the build status
[05:12:04.365] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:04.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:35:0) after 1m0s
[05:13:04.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:35:0)
[05:13:04.437] Timer tick, asking Buildbucket for the build status
[05:13:04.639] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:04.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:36:0) after 1m0s
[05:14:04.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:36:0)
[05:14:04.732] Timer tick, asking Buildbucket for the build status
[05:14:05.025] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:05.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:37:0) after 1m0s
[05:15:05.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:37:0)
[05:15:05.147] Timer tick, asking Buildbucket for the build status
[05:15:06.701] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:06.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:38:0) after 1m0s
[05:16:06.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:38:0)
[05:16:06.731] Timer tick, asking Buildbucket for the build status
[05:16:06.817] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:06.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:39:0) after 1m0s
[05:17:06.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:39:0)
[05:17:06.872] Timer tick, asking Buildbucket for the build status
[05:17:07.074] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:07.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:40:0) after 1m0s
[05:18:07.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:40:0)
[05:18:07.162] Timer tick, asking Buildbucket for the build status
[05:18:07.871] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:07.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:41:0) after 1m0s
[05:19:07.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:41:0)
[05:19:07.938] Timer tick, asking Buildbucket for the build status
[05:19:08.132] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:08.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:42:0) after 1m0s
[05:20:08.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:42:0)
[05:20:08.197] Timer tick, asking Buildbucket for the build status
[05:20:08.315] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:08.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:43:0) after 1m0s
[05:21:08.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:43:0)
[05:21:08.368] Timer tick, asking Buildbucket for the build status
[05:21:08.528] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:08.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:44:0) after 1m0s
[05:22:08.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:44:0)
[05:22:08.590] Timer tick, asking Buildbucket for the build status
[05:22:09.502] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:09.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:45:0) after 1m0s
[05:23:09.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:45:0)
[05:23:09.525] Timer tick, asking Buildbucket for the build status
[05:23:09.794] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:09.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:46:0) after 1m0s
[05:24:09.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:46:0)
[05:24:09.821] Timer tick, asking Buildbucket for the build status
[05:24:10.035] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:10.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:47:0) after 1m0s
[05:25:10.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:47:0)
[05:25:10.091] Timer tick, asking Buildbucket for the build status
[05:25:10.526] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:10.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:48:0) after 1m0s
[05:26:10.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:48:0)
[05:26:10.559] Timer tick, asking Buildbucket for the build status
[05:26:10.673] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:10.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:49:0) after 1m0s
[05:27:10.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:49:0)
[05:27:10.727] Timer tick, asking Buildbucket for the build status
[05:27:11.079] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:11.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:50:0) after 1m0s
[05:28:11.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:50:0)
[05:28:11.129] Timer tick, asking Buildbucket for the build status
[05:28:11.238] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:11.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:51:0) after 1m0s
[05:29:11.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:51:0)
[05:29:11.290] Timer tick, asking Buildbucket for the build status
[05:29:11.470] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:52:0) after 1m0s
[05:30:11.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:52:0)
[05:30:11.492] Timer tick, asking Buildbucket for the build status
[05:30:11.627] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:11.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:53:0) after 1m0s
[05:31:11.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:53:0)
[05:31:11.682] Timer tick, asking Buildbucket for the build status
[05:31:11.808] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:11.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:54:0) after 1m0s
[05:32:11.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:54:0)
[05:32:11.845] Timer tick, asking Buildbucket for the build status
[05:32:11.953] Build 8887420879669250720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:11.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052850941792475216:55:0) after 1m0s
[05:33:09.454] Received PubSub notification, asking Buildbucket for the build status
[05:33:09.865] Build 8887420879669250720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:33:09.865] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582695188795802",
"created_by": "project:chromium",
"created_ts": "1582691990174562",
"id": "8887420879669250720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef536f4dd9b25111fb00d86fa3cda443d9bd1952\"}}",
"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\"}, \"$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-95-x5dz\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169029, \"got_angle_revision\": \"a1ceb87b4b8daadf6a90ad5020517062a80b02b2\", \"got_dawn_revision\": \"227568451b442ae16873ec23cd4b86cf28d00b2a\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"ef536f4dd9b25111fb00d86fa3cda443d9bd1952\", \"got_revision_cp\": \"refs/heads/master@{#744544}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"57083a22efbe63d75af8adb979583fa3aa0ff0d4\", \"got_v8_revision_cp\": \"refs/heads/8.2.173@{#1}\", \"got_webrtc_revision\": \"a6db9c8fe9276774e3939d577c9320ad00fddd83\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef536f4dd9b25111fb00d86fa3cda443d9bd1952\", \"swarm_hashes_refs/heads/master(at){#744544}_without_patch\": {\"accessibility_unittests\": \"c62d27a29d8190bce763c2b87ba5e4ef452c670b\", \"angle_unittests\": \"08ebf1d2151ad60dbd7dee5413824bcf79355f95\", \"app_shell_unittests\": \"903d86c783a71345ad5e6b448bd885e013d08906\", \"aura_unittests\": \"81f74b919678e48637307c623995f5b33df54c4f\", \"base_unittests\": \"1e4c2b7aa313abc19f4e9d7187fbfbb81c627492\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"1a7f3d555da146ba793662356712715ffe4e6108\", \"blink_fuzzer_unittests\": \"e50dc0eca52f6b113e1295a8930a027c2b6fa9bd\", \"blink_heap_unittests\": \"212f1de04fe8a7ef930430fffce0ae78d8ef6ede\", \"blink_platform_unittests\": \"201b2c5c19a0087d9c8975172910b275cddfa792\", \"blink_python_tests\": \"bca77ab4a3bdc4ca763dca829c6baee146cac25c\", \"blink_unittests\": \"02de5255559775ef875c21215e618c0a927014dd\", \"blink_web_tests\": \"2fc9da815cf26f6c2b44c7576ddf96572253bd4c\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"a3abcde724b8f0f40f7bef6fc719c204f094ed68\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"5bf23b408703fb4911f5b81b6ad6f7970333ff4f\", \"cast_unittests\": \"94bffaab4cfc82885e65c714335ebc6b9dc72215\", \"cc_unittests\": \"123ad60f1b21cd2777d7485fe76aff28dbc1dcdc\", \"chrome_app_unittests\": \"988c6232a1c7cee8fdfb962e3aec13aa4e719eaa\", \"chromedriver_unittests\": \"5d712cf719539d589dd5c61e060c8991d3871d43\", \"components_browsertests\": \"b4a2f86ec5264c34f446f2e72004ff2ca428f798\", \"components_unittests\": \"811a4a08c486184f1b6f3aab0476f827e94c9173\", \"compositor_unittests\": \"7afe0e1973f546fce7ff2a2d3da86dd3531eb424\", \"content_browsertests\": \"3b1de50a3f600ca7858403d01d2d19cd2b83bcc9\", \"content_shell_crash_test\": \"1a324815a4d511425ab46f34867c65b2709af121\", \"content_unittests\": \"98135bba5ff28c13c7a86c905bd3db1e18bb32eb\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"e29f5972eb14162c80f789166474dc5aa89b408d\", \"cronet_unittests\": \"08c9d60a55c36f1ed551e5a8327ffb2ad6855d37\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"345fb874fd9b17a3011895c0bd04da10b139c7e3\", \"display_unittests\": \"aa040e39fafb85edfa8c581fe0ed81d7bff0d318\", \"events_unittests\": \"610076d5452fbe5aa8d6c9647fd5b4af17644944\", \"extensions_browsertests\": \"51729c109302f1de4fad8735ae29e4f626b4043e\", \"extensions_unittests\": \"fe645b15ce04abf887b5ce516329d483b74faa4e\", \"filesystem_service_unittests\": \"4342b3e6831e2743ebbd619269ec5d9b2c1edd15\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"a3f7dc880db0e608ff493ce6632df30a73fe70fc\", \"gfx_unittests\": \"a3d205e91cdc002f21a20fd938ae13861033db50\", \"gin_unittests\": \"f85f930f4c7e2700709157f4e7fd65bbaa841aa9\", \"google_apis_unittests\": \"f46d5ae85e2e941232d7ee3b068febe364fb56c8\", \"gpu_unittests\": \"13b721689728d0009ac88cfdacc449cfc766b165\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"618cd29377c948d26cc07439c81fe17fabf2ebb9\", \"headless_unittests\": \"84d3b7a39731d744fdb54ba735c1f6cfe45691a5\", \"interactive_ui_tests\": \"38bdf7381c14d1748d58be929ea42aeedf42c972\", \"ipc_tests\": \"e0f7b187ef2401acfa60df4d22f697e52091f20d\", \"jingle_unittests\": \"091164be57f1334139783971061dfbec68e87e56\", \"latency_unittests\": \"261a0e01a3662796e54f6f9b88383293a1bcceb7\", \"libjingle_xmpp_unittests\": \"f161e3c75b454e72ff0fc0b413426003ef953725\", \"media_blink_unittests\": \"4e42e3e3b2c9a09f7f4f6b20278eeb0c64aef6ae\", \"media_service_unittests\": \"cc6f05754a3214b19adb55208831d1d1c32dd589\", \"media_unittests\": \"9dbc5abfe9de01605545b4d077c9df1235f5d662\", \"message_center_unittests\": \"64ff33fd49a7b9770f4362871f02c71d399a0a4b\", \"metrics_python_tests\": \"4099190999be6b382001601f61e8542e0d4c3fec\", \"midi_unittests\": \"92e38fcae417ef84dc10be69add165231ccf5ba2\", \"mojo_core_unittests\": \"1bb1e648ef92fa8977968ad2744e53982c4ec9b6\", \"mojo_unittests\": \"847ec2ff2b6ff13647a4ad407493d81e71fa7279\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"d432cd4cd73577f6fbaaf3984111a3d440b7ea8d\", \"native_theme_unittests\": \"170fc4d4414ba302cfe2d95fc36962a4ee3ea779\", \"net_unittests\": \"f18992e58b06a316d3e90495502cd84ae43c6f6b\", \"pdf_unittests\": \"68cb7f8a0f653022dba51f38a6243401c895557d\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"98513de64523d521e5f632e467753be61e1df708\", \"printing_unittests\": \"96aa5c2c9604cf3ac95db8ac29b80fc4575dd7b0\", \"remoting_unittests\": \"5c92511e137219737a62a031678c959f13bb6ab4\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"745d2bd96cbd26b1fbc6d471b20a7b6a36b2372a\", \"services_unittests\": \"5a7ef482954aa6e366bf39262807d283b8bce39e\", \"shell_dialogs_unittests\": \"c7b286d2d06b3a472af239c728f1573f85a303f7\", \"skia_unittests\": \"5f0ef67f9d5a5285a772557a3f617d952f1dc99a\", \"snapshot_unittests\": \"5b06a44c9e29f495e006aed638494bec96f53544\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"de67284fd436c988a8a44ec23582a6f1b7f6942f\", \"sync_integration_tests\": \"54787f572177db8117f4f9ae086543b61fcb1094\", \"telemetry_gpu_unittests\": \"5984ad4072935164e598514becbdb621d81d2313\", \"telemetry_perf_unittests\": \"4a15edf1a4ffda283f6e6194178d75e7773260fe\", \"telemetry_unittests\": \"0b2a525fa5dd64bbe5d6cb4467900198528a6165\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"e105e25a26335aabb6c42acbcdedcd0c061d6d5a\", \"ui_touch_selection_unittests\": \"651e8f4ba9e3e2522c74577ce4036167d6335e2b\", \"unit_tests\": \"a08118634c508239fc88cbbb40ab27ac9ef9499c\", \"url_unittests\": \"3f5171bd43e3cac3eaac90164cae30b03b570e9c\", \"views_perftests\": \"8ebe53f291a6d945894e9312e6e89eb3836a4d41\", \"views_unittests\": \"be5f0004dd32dbd9c5db5fbb29a8ef78a0cfcc04\", \"viz_unittests\": \"1cf925aec90d767ed8b55992703cfa11f724ac3c\", \"vr_common_unittests\": \"6e1588ed12d12855592ebba66b654238cf63c46f\", \"vr_pixeltests\": \"8e1ecaeb334d16d0ef7ec95975544880eba378b5\", \"webdriver_wpt_tests\": \"7c949adf28579d436c2641b2c90c5b862f5477dc\", \"weblayer_browsertests\": \"4a19725fcbf413b77b493b426d02951cbc31fdb9\", \"wm_unittests\": \"c2897fb4cc1f9df58a1d9d7df592cdd7c7c62166\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"5575faf039eb4896171f5d70749a49334a3db698\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-95-x5dz\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582692281351264",
"status": "COMPLETED",
"status_changed_ts": "1582695189069170",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169029",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef536f4dd9b25111fb00d86fa3cda443d9bd1952",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052850941792475216",
"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/8887420879669250720/+/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:4a989cc5c56d5710",
"user_agent:luci-scheduler"
],
"updated_ts": "1582695189072579",
"url": "https://ci.chromium.org/b/8887420879669250720",
"utcnow_ts": "1582695189848827"
}
}
[05:33:09.865] Invocation finished in 53m21.098753675s with status SUCCEEDED