[11:25:40.599] New invocation is queued and will start shortly
[11:25:41.734] Starting the invocation (attempt 1)
[11:25:41.777] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:25:41.778] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:25:41.778] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056721076626026800",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4755a183a2efae767a241f544f79139b7d926872\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056721076626026800",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4755a183a2efae767a241f544f79139b7d926872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4755a183a2efae767a241f544f79139b7d926872",
"gitiles_ref:refs/heads/master"
]
}
[11:25:42.509] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579001141919424",
"id": "8891291014568932432",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4755a183a2efae767a241f544f79139b7d926872\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579001142299687",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167359",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4755a183a2efae767a241f544f79139b7d926872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4755a183a2efae767a241f544f79139b7d926872",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056721076626026800",
"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/8891291014568932432/+/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": "1579001142299831",
"url": "https://ci.chromium.org/b/8891291014568932432",
"utcnow_ts": "1579001142493477"
}
}
[11:25:42.509] Task URL: https://ci.chromium.org/b/8891291014568932432
[11:25:42.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:2:0) after 1m0s
[11:26:42.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:2:0)
[11:26:42.518] Timer tick, asking Buildbucket for the build status
[11:26:42.880] Build 8891291014568932432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:26:42.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:3:0) after 1m0s
[11:27:42.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:3:0)
[11:27:42.951] Timer tick, asking Buildbucket for the build status
[11:27:43.108] Build 8891291014568932432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:27:43.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:4:0) after 1m0s
[11:28:43.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:4:0)
[11:28:43.142] Timer tick, asking Buildbucket for the build status
[11:28:43.358] Build 8891291014568932432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:28:43.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:5:0) after 1m0s
[11:29:43.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:5:0)
[11:29:43.379] Timer tick, asking Buildbucket for the build status
[11:29:43.771] Build 8891291014568932432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:29:43.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:6:0) after 1m0s
[11:30:43.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:6:0)
[11:30:43.836] Timer tick, asking Buildbucket for the build status
[11:30:43.991] Build 8891291014568932432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:30:43.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:7:0) after 1m0s
[11:31:04.505] Received PubSub notification, asking Buildbucket for the build status
[11:31:05.069] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:44.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:7:0)
[11:31:44.156] Timer tick, asking Buildbucket for the build status
[11:31:44.387] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:9:0) after 1m0s
[11:32:44.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:9:0)
[11:32:44.661] Timer tick, asking Buildbucket for the build status
[11:32:44.870] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:44.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:10:0) after 1m0s
[11:33:44.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:10:0)
[11:33:44.975] Timer tick, asking Buildbucket for the build status
[11:33:45.264] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:45.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:11:0) after 1m0s
[11:34:45.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:11:0)
[11:34:45.416] Timer tick, asking Buildbucket for the build status
[11:34:45.751] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:45.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:12:0) after 1m0s
[11:35:45.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:12:0)
[11:35:45.806] Timer tick, asking Buildbucket for the build status
[11:35:46.290] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:46.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:13:0) after 1m0s
[11:36:46.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:13:0)
[11:36:46.371] Timer tick, asking Buildbucket for the build status
[11:36:46.651] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:46.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:14:0) after 1m0s
[11:37:46.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:14:0)
[11:37:46.693] Timer tick, asking Buildbucket for the build status
[11:37:47.449] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:47.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:15:0) after 1m0s
[11:38:47.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:15:0)
[11:38:47.531] Timer tick, asking Buildbucket for the build status
[11:38:47.805] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:47.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:16:0) after 1m0s
[11:39:47.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:16:0)
[11:39:47.865] Timer tick, asking Buildbucket for the build status
[11:39:48.105] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:48.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:17:0) after 1m0s
[11:40:48.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:17:0)
[11:40:48.371] Timer tick, asking Buildbucket for the build status
[11:40:48.754] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:48.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:18:0) after 1m0s
[11:41:48.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:18:0)
[11:41:48.889] Timer tick, asking Buildbucket for the build status
[11:41:49.411] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:49.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:19:0) after 1m0s
[11:42:49.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:19:0)
[11:42:49.646] Timer tick, asking Buildbucket for the build status
[11:42:50.187] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:50.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:20:0) after 1m0s
[11:43:50.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:20:0)
[11:43:50.288] Timer tick, asking Buildbucket for the build status
[11:43:50.564] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:50.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:21:0) after 1m0s
[11:44:50.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:21:0)
[11:44:50.698] Timer tick, asking Buildbucket for the build status
[11:44:50.870] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:50.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:22:0) after 1m0s
[11:45:50.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:22:0)
[11:45:50.962] Timer tick, asking Buildbucket for the build status
[11:45:51.487] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:51.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:23:0) after 1m0s
[11:46:51.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:23:0)
[11:46:51.521] Timer tick, asking Buildbucket for the build status
[11:46:52.005] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:52.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:24:0) after 1m0s
[11:47:52.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:24:0)
[11:47:52.076] Timer tick, asking Buildbucket for the build status
[11:47:52.389] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:52.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:25:0) after 1m0s
[11:48:52.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:25:0)
[11:48:52.371] Timer tick, asking Buildbucket for the build status
[11:48:52.969] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:52.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:26:0) after 1m0s
[11:49:53.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:26:0)
[11:49:53.035] Timer tick, asking Buildbucket for the build status
[11:49:53.970] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:53.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:27:0) after 1m0s
[11:50:54.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:27:0)
[11:50:54.105] Timer tick, asking Buildbucket for the build status
[11:50:54.490] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:54.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:28:0) after 1m0s
[11:51:54.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:28:0)
[11:51:54.566] Timer tick, asking Buildbucket for the build status
[11:51:54.704] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:29:0) after 1m0s
[11:52:54.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:29:0)
[11:52:54.739] Timer tick, asking Buildbucket for the build status
[11:52:55.050] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:55.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:30:0) after 1m0s
[11:53:55.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:30:0)
[11:53:55.103] Timer tick, asking Buildbucket for the build status
[11:53:55.463] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:55.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:31:0) after 1m0s
[11:54:55.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:31:0)
[11:54:55.520] Timer tick, asking Buildbucket for the build status
[11:54:56.058] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:56.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:32:0) after 1m0s
[11:55:56.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:32:0)
[11:55:56.218] Timer tick, asking Buildbucket for the build status
[11:55:56.741] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:56.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:33:0) after 1m0s
[11:56:56.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:33:0)
[11:56:56.731] Timer tick, asking Buildbucket for the build status
[11:56:57.381] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:57.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:34:0) after 1m0s
[11:57:57.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:34:0)
[11:57:57.412] Timer tick, asking Buildbucket for the build status
[11:57:57.991] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:57.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:35:0) after 1m0s
[11:58:58.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:35:0)
[11:58:58.015] Timer tick, asking Buildbucket for the build status
[11:58:58.324] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:58.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:36:0) after 1m0s
[11:59:58.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:36:0)
[11:59:58.338] Timer tick, asking Buildbucket for the build status
[11:59:58.667] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:58.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:37:0) after 1m0s
[12:00:58.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:37:0)
[12:00:58.650] Timer tick, asking Buildbucket for the build status
[12:00:59.040] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:38:0) after 1m0s
[12:01:59.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:38:0)
[12:01:59.097] Timer tick, asking Buildbucket for the build status
[12:02:00.109] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:00.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:39:0) after 1m0s
[12:03:00.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:39:0)
[12:03:00.135] Timer tick, asking Buildbucket for the build status
[12:03:00.327] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:00.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:40:0) after 1m0s
[12:04:00.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:40:0)
[12:04:00.381] Timer tick, asking Buildbucket for the build status
[12:04:00.640] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:41:0) after 1m0s
[12:05:00.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:41:0)
[12:05:00.655] Timer tick, asking Buildbucket for the build status
[12:05:00.931] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:42:0) after 1m0s
[12:06:00.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:42:0)
[12:06:00.967] Timer tick, asking Buildbucket for the build status
[12:06:01.214] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:01.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:43:0) after 1m0s
[12:07:01.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:43:0)
[12:07:01.333] Timer tick, asking Buildbucket for the build status
[12:07:01.595] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:01.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:44:0) after 1m0s
[12:08:02.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:44:0)
[12:08:02.167] Timer tick, asking Buildbucket for the build status
[12:08:02.348] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:02.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:45:0) after 1m0s
[12:09:02.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:45:0)
[12:09:02.344] Timer tick, asking Buildbucket for the build status
[12:09:02.932] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:02.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:46:0) after 1m0s
[12:10:03.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:46:0)
[12:10:03.048] Timer tick, asking Buildbucket for the build status
[12:10:04.483] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:04.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:47:0) after 1m0s
[12:11:04.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:47:0)
[12:11:04.581] Timer tick, asking Buildbucket for the build status
[12:11:04.945] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:48:0) after 1m0s
[12:12:05.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:48:0)
[12:12:05.265] Timer tick, asking Buildbucket for the build status
[12:12:05.632] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:05.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:49:0) after 1m0s
[12:13:05.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:49:0)
[12:13:05.805] Timer tick, asking Buildbucket for the build status
[12:13:06.375] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:06.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:50:0) after 1m0s
[12:14:06.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:50:0)
[12:14:06.503] Timer tick, asking Buildbucket for the build status
[12:14:06.809] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:06.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:51:0) after 1m0s
[12:15:06.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:51:0)
[12:15:06.913] Timer tick, asking Buildbucket for the build status
[12:15:07.081] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:07.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:52:0) after 1m0s
[12:16:07.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:52:0)
[12:16:07.127] Timer tick, asking Buildbucket for the build status
[12:16:07.550] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:07.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:53:0) after 1m0s
[12:17:07.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:53:0)
[12:17:07.598] Timer tick, asking Buildbucket for the build status
[12:17:08.106] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:08.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:54:0) after 1m0s
[12:18:08.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:54:0)
[12:18:08.134] Timer tick, asking Buildbucket for the build status
[12:18:09.131] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:09.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:55:0) after 1m0s
[12:19:09.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:55:0)
[12:19:09.194] Timer tick, asking Buildbucket for the build status
[12:19:09.389] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:56:0) after 1m0s
[12:20:09.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:56:0)
[12:20:09.501] Timer tick, asking Buildbucket for the build status
[12:20:10.574] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:10.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:57:0) after 1m0s
[12:21:10.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:57:0)
[12:21:10.664] Timer tick, asking Buildbucket for the build status
[12:21:10.876] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:10.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:58:0) after 1m0s
[12:22:10.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:58:0)
[12:22:10.978] Timer tick, asking Buildbucket for the build status
[12:22:11.177] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:11.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:59:0) after 1m0s
[12:23:11.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:59:0)
[12:23:11.201] Timer tick, asking Buildbucket for the build status
[12:23:11.356] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:11.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:60:0) after 1m0s
[12:24:11.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:60:0)
[12:24:11.523] Timer tick, asking Buildbucket for the build status
[12:24:11.752] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:11.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:61:0) after 1m0s
[12:25:11.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:61:0)
[12:25:11.796] Timer tick, asking Buildbucket for the build status
[12:25:12.038] Build 8891291014568932432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:12.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056721076626026800:62:0) after 1m0s
[12:25:17.624] Received PubSub notification, asking Buildbucket for the build status
[12:25:18.727] Build 8891291014568932432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:25:18.727] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579004716787920",
"created_by": "project:chromium",
"created_ts": "1579001141919424",
"id": "8891291014568932432",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4755a183a2efae767a241f544f79139b7d926872\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-62-qu97\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167359, \"got_angle_revision\": \"8b3a0fa8105082771d4a0d39cf87cf9c74c8f139\", \"got_dawn_revision\": \"e5cb8f2eff7e2b0f672c0d20fb97ca17fe28e94a\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"4755a183a2efae767a241f544f79139b7d926872\", \"got_revision_cp\": \"refs/heads/master@{#731235}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"488d35ac0b1c66c79a6a8511111ad5b6296a2ffb\", \"got_v8_revision\": \"3d04bd15b02d40f716b49dbb1cb97bb13c40741a\", \"got_v8_revision_cp\": \"refs/heads/8.1.170@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4755a183a2efae767a241f544f79139b7d926872\", \"swarm_hashes_refs/heads/master(at){#731235}_without_patch\": {\"accessibility_unittests\": \"d2e5a186d3b1cf0a7d958f1ad6729175736d1201\", \"angle_unittests\": \"82df43952b1d80bf68130ce6ea65cca0cd11cfb7\", \"app_shell_unittests\": \"1ba077ac4476d4b48d1e7a0c72ea619ba2da320a\", \"aura_unittests\": \"7cd33c5a7e4f3820b8357f70966de06db6f087fc\", \"base_unittests\": \"e44fbd8797359d0138ba2b7de8399d42396a5a64\", \"base_util_unittests\": \"1f34251a716d40e930d9ea93b01ddb101b9b17f8\", \"blink_common_unittests\": \"b9d9ee0ee1d9ac926007d81bbd839eec0a11a1a1\", \"blink_fuzzer_unittests\": \"65ba68f6ac1d7aec880ac954582b849b552cef96\", \"blink_heap_unittests\": \"5c1e9d36f0c43891aabb90fe20cf50f9d0703db5\", \"blink_platform_unittests\": \"dec520e8c5a963307ba0c64c2ad7c21d7f77985f\", \"blink_python_tests\": \"40d613c22feea0b05d1109cf8ef4eff99d9963e1\", \"blink_unittests\": \"9712f089d9877d5f87a4fc9cf5d42c7a00fec3cd\", \"blink_web_tests\": \"62def88ff0ed078f01329c31ecbc8299a25f452f\", \"boringssl_crypto_tests\": \"f3e3bf3ad7d9fb66d0fa1cc86ab3c7b1caf8f426\", \"boringssl_ssl_tests\": \"5ef6078f098b9fc7a6535bea84ab6df81a51a6e3\", \"browser_tests\": \"8b265e0b822ede847272cd58ff9ab9f2dac05998\", \"cacheinvalidation_unittests\": \"5635e9c8c80b824a8a01089259c55bf7d0a2b0b2\", \"capture_unittests\": \"a3a2944e4344d303a2288ea4970c0d44a61f6d73\", \"cast_unittests\": \"f36a4f2c0ed0b29cbf54d9ba66cc63cbcb25b3a1\", \"cc_unittests\": \"5ccac5afdcefbdbe8cf54b0f831f8f6b8040ef4c\", \"chrome_app_unittests\": \"8f7dc73936614b5ef720080e1a9a7204fecfb363\", \"chromedriver_unittests\": \"46b386e1f342a173c91bf0fc67e6a9b6097e31b7\", \"components_browsertests\": \"602521f0ea842b0ae4540836c965dac4f2c6ab3a\", \"components_unittests\": \"5b97ba2a9528203c1aee93e5ae1df494e66e14da\", \"compositor_unittests\": \"6472cc8bf9e1b1153e71fb032197fbff2a486640\", \"content_browsertests\": \"56fbb284c58da128b7df96772911433f7dd2b2cc\", \"content_shell_crash_test\": \"14c78807ba07510c04ee3cb8aaeee1315e595808\", \"content_unittests\": \"33418484e98a29b2b19a5afddf16414c0ee82f2a\", \"crashpad_tests\": \"e673ab78b6720de5de6a54ffc56736ba7fc0f707\", \"cronet_tests\": \"76b570a5d62bdb7998be6133ca6b4fcedfda34d3\", \"cronet_unittests\": \"78127c5e0d77a3f97cab38a0ba1a09aaa3a4dba0\", \"crypto_unittests\": \"c6e2381485f3b49284da82defbc5c97a4af31d73\", \"dbus_unittests\": \"ac862fc8720953ec8ef50f9a2b8a30e28fef7bd7\", \"device_unittests\": \"1be050b8d220383a2547b202f5b8d3429a1202c7\", \"devtools_lint_check\": \"b58c145b351b43910b26b397d13cd04c571e1a50\", \"devtools_type_check\": \"8156dd0c35dcd076013808a11a4cf35c8315884e\", \"display_unittests\": \"8f16ac3e3b17f75daece7f1275db2b556d2dc1b4\", \"events_unittests\": \"47c22aa666583a27b491108de31962171c3de028\", \"extensions_browsertests\": \"734f229b714560c4096d9e90e68ec9cea236bf1e\", \"extensions_unittests\": \"d80d0f4b251947abacd7aebb5c91c0986084c39a\", \"filesystem_service_unittests\": \"2618bd7f2973c012742a3e2fd2dc300d3de64ffa\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"d447cb95ba2da48057ba3f304af19f2825590849\", \"gfx_unittests\": \"50dbcb6fc5093468c637c254e0f16d4118ead8a8\", \"gin_unittests\": \"5f3ef4a42ecc3667148bab30a16e977333ce5a08\", \"google_apis_unittests\": \"7141563e41a1a1f428d19c07783ef9e4621f74f2\", \"gpu_unittests\": \"90e3824f9b4a63b07c0c70d4cdf2992eea372464\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"d06f528c117f8847434f929339b5dec4f0fb7772\", \"headless_browsertests\": \"eb3cb794142bfc59492b4cc94322fc86c6edfd1d\", \"headless_unittests\": \"684ff1ac9d016fedc4ba6d55feeb66bd8b3f1e18\", \"interactive_ui_tests\": \"744c34086e5e153c1e6d0b945ee21d4b97309553\", \"ipc_tests\": \"fc422e669702914212734a6999ff449115826abd\", \"jingle_unittests\": \"c2da6b6a155b3e10cecd997a0d3881964ab806b5\", \"latency_unittests\": \"10de99321de5ccfd0d788edad8dc4bbb92e93ad7\", \"libjingle_xmpp_unittests\": \"ab6e0269ff418d38eee7b46caee5775f50f38f2d\", \"media_blink_unittests\": \"59c54221e8e8eb383aa4000c1e6ac06e5a0a067b\", \"media_service_unittests\": \"586e47890ed9389ae5baa743fd7986c5a7d8cb97\", \"media_unittests\": \"12db965eb53f82dcb3cfcdd9ad0a72c5639f05a6\", \"message_center_unittests\": \"c74b071edbe09128d99d5cd61976c589089ef242\", \"metrics_python_tests\": \"65fd0ffb167f4f57abbdf9ff685f59ce4e18bbe2\", \"midi_unittests\": \"5b2a35d1469f3086e04d69fdb88411a1cbcc1921\", \"mojo_core_unittests\": \"903e17975da14e7762fa6cbef57f4ccb85ca0fd7\", \"mojo_unittests\": \"0f2615df2ffd1ba996f13a1e1ae4f5dd3cf8c405\", \"nacl_helper_nonsfi_unittests\": \"216da23ad00da3c11569ce8cccfa392d6422d35d\", \"nacl_loader_unittests\": \"e46417b92b982f1e867290cc5a19969b9f146933\", \"native_theme_unittests\": \"456467b6f26a4c0e30f1c9794f602aa7558adfe5\", \"net_unittests\": \"03a6484f10c47ff047dc98457616d82a45a28265\", \"pdf_unittests\": \"495984b9443a459394afe400c55886806e50915a\", \"perfetto_unittests\": \"7edb4c30f1d678c436a3ba3cf51c8f2d61503d4a\", \"ppapi_unittests\": \"94bd96ff9b70a23b9a6bdb30d07f414e7852fbd1\", \"printing_unittests\": \"e54bbf42d40af2069942e742bcadab9fb2114fec\", \"remoting_unittests\": \"cd966459469ce92bfd7bc0a3243d22446e580f8b\", \"sandbox_linux_unittests\": \"4bc9720ccf68447e7f1fdf8ee62a717ff29917a9\", \"service_manager_unittests\": \"053e56b042200aace7515de37e1dcf1bc5576449\", \"services_unittests\": \"3052c8d97c1b377faaaa21e86bead2aa7b402e84\", \"shell_dialogs_unittests\": \"60bf158b4fd7f4a9d2f6e718784f05105a9d0da8\", \"skia_unittests\": \"bbc50c96b687807f01b7afaf7c63aafdac888bd9\", \"snapshot_unittests\": \"c2e8b1f39df266b51cb3bdbea2cfd693644e5fd5\", \"sql_unittests\": \"8ac659a63ab5cf99e04b368483c57a67040653be\", \"storage_unittests\": \"ca14f191fe43341f4155a98ebb5e2cc34f9f31cb\", \"sync_integration_tests\": \"818cf89ecf417330ab776f374ce9727803b649fb\", \"telemetry_gpu_unittests\": \"62b246ffec1d0616d3558576befb9640ffabf7f4\", \"telemetry_perf_unittests\": \"ad71d5cbe7ec5b7e62c590edb78114f0778fe958\", \"telemetry_unittests\": \"195cef0ad430d83b943c58af6956a7414f4748a7\", \"traffic_annotation_auditor_unittests\": \"ef3d1150c7e2bf41d9cd43d557f348c78cbe9bc4\", \"ui_base_unittests\": \"f4208abefb90c0b4a047b0605ee2093e88a9c06c\", \"ui_touch_selection_unittests\": \"3e2adb1073ba6e76353937a39d952675b660dbad\", \"unit_tests\": \"2d66c9469b4ae22c71eb84a8f13a7952d070266e\", \"url_unittests\": \"637e6a76f07a9ac1b55d258ba1df957d42c86be7\", \"views_perftests\": \"2c62699d60852333bb309feac99efd8b0cb8ba4d\", \"views_unittests\": \"d6c4d993108ec2ce59987d18250c45b0d1730959\", \"viz_unittests\": \"cd949bd790185a5f3b5a2ec7e63a7c081f6978b3\", \"vr_common_unittests\": \"e4a55dfedf8ab9e00fd2459fd4eb77d1532178e2\", \"vr_pixeltests\": \"7aa6e237a82b14bab0cc3e6a41d7bc289897ff96\", \"webdriver_wpt_tests\": \"7faaecab6b1a3628a760c9afb4f95b00994de480\", \"weblayer_browsertests\": \"404080a7de165d14bc59ef109e217388e4b55d40\", \"wm_unittests\": \"d72bce9edce0b08dfdce299a616c20454b20249b\", \"wtf_unittests\": \"74ca7a375286cc0eedf291a7293fa4c914e794d8\", \"xr_browser_tests\": \"38d8a09188fe9c97e2c4c814a2681fc2832473a9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_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-62-qu97\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579001463583076",
"status": "COMPLETED",
"status_changed_ts": "1579004717208401",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167359",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4755a183a2efae767a241f544f79139b7d926872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4755a183a2efae767a241f544f79139b7d926872",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056721076626026800",
"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/8891291014568932432/+/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:49bc9f76e2ae1a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579004717217156",
"url": "https://ci.chromium.org/b/8891291014568932432",
"utcnow_ts": "1579004718686639"
}
}
[12:25:18.727] Invocation finished in 59m38.152795045s with status SUCCEEDED