[03:10:55.133] New invocation is queued and will start shortly
[03:10:56.421] Starting the invocation (attempt 1)
[03:10:56.508] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:10:56.508] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:10:56.509] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053490713302748256",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48a8cf458b1a5b7f235695c37b396fc4b828ebee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053490713302748256",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"gitiles_ref:refs/heads/master"
]
}
[03:10:57.116] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582081856660595",
"id": "8888060651029264112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48a8cf458b1a5b7f235695c37b396fc4b828ebee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582081857012338",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168774",
"builder:Linux Builder (dbg)",
"buildset:commit/git/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053490713302748256",
"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/8888060651029264112/+/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": "1582081857012448",
"url": "https://ci.chromium.org/b/8888060651029264112",
"utcnow_ts": "1582081857106923"
}
}
[03:10:57.116] Task URL: https://ci.chromium.org/b/8888060651029264112
[03:10:57.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:2:0) after 1m0s
[03:11:57.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:2:0)
[03:11:57.171] Timer tick, asking Buildbucket for the build status
[03:11:57.335] Build 8888060651029264112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:57.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:3:0) after 1m0s
[03:12:57.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:3:0)
[03:12:57.402] Timer tick, asking Buildbucket for the build status
[03:12:57.624] Build 8888060651029264112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:57.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:4:0) after 1m0s
[03:13:57.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:4:0)
[03:13:57.653] Timer tick, asking Buildbucket for the build status
[03:13:57.824] Build 8888060651029264112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:57.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:5:0) after 1m0s
[03:14:57.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:5:0)
[03:14:57.827] Timer tick, asking Buildbucket for the build status
[03:14:58.085] Build 8888060651029264112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:58.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:6:0) after 1m0s
[03:15:04.944] Received PubSub notification, asking Buildbucket for the build status
[03:15:05.076] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:6:0)
[03:15:58.129] Timer tick, asking Buildbucket for the build status
[03:15:58.476] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:8:0) after 1m0s
[03:16:58.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:8:0)
[03:16:58.526] Timer tick, asking Buildbucket for the build status
[03:16:58.599] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:58.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:9:0) after 1m0s
[03:17:58.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:9:0)
[03:17:58.660] Timer tick, asking Buildbucket for the build status
[03:17:58.884] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:58.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:10:0) after 1m0s
[03:18:58.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:10:0)
[03:18:58.961] Timer tick, asking Buildbucket for the build status
[03:18:59.077] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:59.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:11:0) after 1m0s
[03:19:59.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:11:0)
[03:19:59.156] Timer tick, asking Buildbucket for the build status
[03:19:59.440] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:59.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:12:0) after 1m0s
[03:20:59.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:12:0)
[03:20:59.526] Timer tick, asking Buildbucket for the build status
[03:20:59.631] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:59.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:13:0) after 1m0s
[03:21:59.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:13:0)
[03:21:59.658] Timer tick, asking Buildbucket for the build status
[03:22:00.098] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:00.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:14:0) after 1m0s
[03:23:00.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:14:0)
[03:23:00.130] Timer tick, asking Buildbucket for the build status
[03:23:00.262] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:00.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:15:0) after 1m0s
[03:24:00.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:15:0)
[03:24:00.365] Timer tick, asking Buildbucket for the build status
[03:24:00.551] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:00.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:16:0) after 1m0s
[03:25:00.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:16:0)
[03:25:00.553] Timer tick, asking Buildbucket for the build status
[03:25:00.682] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:00.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:17:0) after 1m0s
[03:26:00.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:17:0)
[03:26:00.928] Timer tick, asking Buildbucket for the build status
[03:26:01.006] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:01.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:18:0) after 1m0s
[03:27:01.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:18:0)
[03:27:01.041] Timer tick, asking Buildbucket for the build status
[03:27:01.145] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:01.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:19:0) after 1m0s
[03:28:01.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:19:0)
[03:28:01.299] Timer tick, asking Buildbucket for the build status
[03:28:01.384] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:01.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:20:0) after 1m0s
[03:29:01.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:20:0)
[03:29:01.524] Timer tick, asking Buildbucket for the build status
[03:29:01.771] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:01.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:21:0) after 1m0s
[03:30:01.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:21:0)
[03:30:01.898] Timer tick, asking Buildbucket for the build status
[03:30:02.267] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:02.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:22:0) after 1m0s
[03:31:02.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:22:0)
[03:31:02.362] Timer tick, asking Buildbucket for the build status
[03:31:02.612] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:02.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:23:0) after 1m0s
[03:32:02.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:23:0)
[03:32:02.704] Timer tick, asking Buildbucket for the build status
[03:32:02.801] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:02.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:24:0) after 1m0s
[03:33:02.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:24:0)
[03:33:02.852] Timer tick, asking Buildbucket for the build status
[03:33:03.112] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:03.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:25:0) after 1m0s
[03:34:03.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:25:0)
[03:34:03.183] Timer tick, asking Buildbucket for the build status
[03:34:03.317] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:03.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:26:0) after 1m0s
[03:35:03.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:26:0)
[03:35:03.367] Timer tick, asking Buildbucket for the build status
[03:35:03.489] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:03.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:27:0) after 1m0s
[03:36:03.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:27:0)
[03:36:03.524] Timer tick, asking Buildbucket for the build status
[03:36:03.671] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:03.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:28:0) after 1m0s
[03:37:03.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:28:0)
[03:37:03.693] Timer tick, asking Buildbucket for the build status
[03:37:03.892] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:03.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:29:0) after 1m0s
[03:38:03.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:29:0)
[03:38:03.926] Timer tick, asking Buildbucket for the build status
[03:38:06.043] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:06.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:30:0) after 1m0s
[03:39:06.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:30:0)
[03:39:06.139] Timer tick, asking Buildbucket for the build status
[03:39:06.239] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:06.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:31:0) after 1m0s
[03:40:06.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:31:0)
[03:40:06.355] Timer tick, asking Buildbucket for the build status
[03:40:06.453] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:32:0) after 1m0s
[03:41:06.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:32:0)
[03:41:06.595] Timer tick, asking Buildbucket for the build status
[03:41:06.776] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:33:0) after 1m0s
[03:42:06.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:33:0)
[03:42:06.796] Timer tick, asking Buildbucket for the build status
[03:42:07.506] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:07.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:34:0) after 1m0s
[03:43:07.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:34:0)
[03:43:07.522] Timer tick, asking Buildbucket for the build status
[03:43:07.798] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:07.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:35:0) after 1m0s
[03:44:07.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:35:0)
[03:44:07.949] Timer tick, asking Buildbucket for the build status
[03:44:08.114] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:36:0) after 1m0s
[03:45:08.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:36:0)
[03:45:08.193] Timer tick, asking Buildbucket for the build status
[03:45:08.545] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:37:0) after 1m0s
[03:46:08.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:37:0)
[03:46:08.580] Timer tick, asking Buildbucket for the build status
[03:46:08.698] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:08.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:38:0) after 1m0s
[03:47:08.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:38:0)
[03:47:08.728] Timer tick, asking Buildbucket for the build status
[03:47:08.899] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:08.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:39:0) after 1m0s
[03:48:08.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:39:0)
[03:48:08.946] Timer tick, asking Buildbucket for the build status
[03:48:09.160] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:09.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:40:0) after 1m0s
[03:49:09.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:40:0)
[03:49:09.178] Timer tick, asking Buildbucket for the build status
[03:49:09.321] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:09.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:41:0) after 1m0s
[03:50:09.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:41:0)
[03:50:09.569] Timer tick, asking Buildbucket for the build status
[03:50:09.774] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:09.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:42:0) after 1m0s
[03:51:09.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:42:0)
[03:51:09.892] Timer tick, asking Buildbucket for the build status
[03:51:10.269] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:10.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:43:0) after 1m0s
[03:52:10.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:43:0)
[03:52:10.401] Timer tick, asking Buildbucket for the build status
[03:52:10.581] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:10.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:44:0) after 1m0s
[03:53:10.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:44:0)
[03:53:10.626] Timer tick, asking Buildbucket for the build status
[03:53:10.725] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:45:0) after 1m0s
[03:54:10.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:45:0)
[03:54:10.739] Timer tick, asking Buildbucket for the build status
[03:54:10.904] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:10.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:46:0) after 1m0s
[03:55:10.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:46:0)
[03:55:10.930] Timer tick, asking Buildbucket for the build status
[03:55:11.044] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:11.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:47:0) after 1m0s
[03:56:11.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:47:0)
[03:56:11.129] Timer tick, asking Buildbucket for the build status
[03:56:11.292] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:11.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:48:0) after 1m0s
[03:57:11.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:48:0)
[03:57:11.320] Timer tick, asking Buildbucket for the build status
[03:57:11.422] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:49:0) after 1m0s
[03:58:11.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:49:0)
[03:58:11.606] Timer tick, asking Buildbucket for the build status
[03:58:11.707] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:11.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:50:0) after 1m0s
[03:59:11.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:50:0)
[03:59:11.737] Timer tick, asking Buildbucket for the build status
[03:59:11.991] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:11.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:51:0) after 1m0s
[04:00:12.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:51:0)
[04:00:12.016] Timer tick, asking Buildbucket for the build status
[04:00:12.173] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:12.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:52:0) after 1m0s
[04:01:12.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:52:0)
[04:01:12.301] Timer tick, asking Buildbucket for the build status
[04:01:12.601] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:12.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:53:0) after 1m0s
[04:02:12.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:53:0)
[04:02:12.697] Timer tick, asking Buildbucket for the build status
[04:02:13.118] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:13.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:54:0) after 1m0s
[04:03:13.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:54:0)
[04:03:13.182] Timer tick, asking Buildbucket for the build status
[04:03:13.406] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:13.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:55:0) after 1m0s
[04:04:13.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:55:0)
[04:04:13.552] Timer tick, asking Buildbucket for the build status
[04:04:13.660] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:13.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:56:0) after 1m0s
[04:05:13.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:56:0)
[04:05:13.685] Timer tick, asking Buildbucket for the build status
[04:05:13.862] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:13.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:57:0) after 1m0s
[04:06:13.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:57:0)
[04:06:13.933] Timer tick, asking Buildbucket for the build status
[04:06:14.310] Build 8888060651029264112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:14.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053490713302748256:58:0) after 1m0s
[04:06:36.484] Received PubSub notification, asking Buildbucket for the build status
[04:06:36.809] Build 8888060651029264112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:06:36.809] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582085195525663",
"created_by": "project:chromium",
"created_ts": "1582081856660595",
"id": "8888060651029264112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48a8cf458b1a5b7f235695c37b396fc4b828ebee\"}}",
"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-east1-d-8-11-ugpr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168774, \"got_angle_revision\": \"123fd97000bb9fd912159bb9ccc62308b763aead\", \"got_dawn_revision\": \"0aa86a7ae8315f93f9501323dc082af0ac869efc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"48a8cf458b1a5b7f235695c37b396fc4b828ebee\", \"got_revision_cp\": \"refs/heads/master@{#742453}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8def9063c4fdefa8e644198d2254ef279952c88b\", \"got_v8_revision\": \"cc42eb9c520b5f852717223419b39a46a119e453\", \"got_v8_revision_cp\": \"refs/heads/8.2.114@{#1}\", \"got_webrtc_revision\": \"1282babe6621d3a2084bbd24e77652e0b3a4eb93\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30549}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48a8cf458b1a5b7f235695c37b396fc4b828ebee\", \"swarm_hashes_refs/heads/master(at){#742453}_without_patch\": {\"accessibility_unittests\": \"350ccd10c56769cba7c1a1b2a1df882f213f8dc1\", \"angle_unittests\": \"abb8f29ccd855adad0bc6cddc4d19adb07be7b16\", \"app_shell_unittests\": \"0b97fc5396c9509ac8305c15f63bdb006c68411b\", \"aura_unittests\": \"ce700b8bbcb0b8f58d667b15e1baf4b2162a5316\", \"base_unittests\": \"d89380744a36e0de940023eae2aaf800da772cd6\", \"base_util_unittests\": \"468deb0cf39f9fef5e3d18baa5a8609b86f47b57\", \"blink_common_unittests\": \"007e3cc2663e1ef70e15a74db05b3fd9ec2271c7\", \"blink_fuzzer_unittests\": \"9dd1fe3aff29f50bf78cf97908414a33ea5184b9\", \"blink_heap_unittests\": \"49b9d906824c28718c737d9ffba81d214c1a3d26\", \"blink_platform_unittests\": \"01e939d426f4fd481f0decaa8191d50ba590d5db\", \"blink_python_tests\": \"30b36557f41f6a84014cff07164e8505d1bccefb\", \"blink_unittests\": \"331a881664a0c2dd113813d0137a0e50f16b72ae\", \"blink_web_tests\": \"ab21f3d1863adc2a982b7432f59fd0c4f8c0cab3\", \"boringssl_crypto_tests\": \"9ca2279dbeb2756495ac34cf237e59358588fb48\", \"boringssl_ssl_tests\": \"53725b9d83fa01fe5ec43a0332dfbd8f52c4fb60\", \"browser_tests\": \"679cd1737abcfba36a044c8c2084d197e7442b43\", \"cacheinvalidation_unittests\": \"323e1e46995659bd764637a2e9c566a75979b25a\", \"capture_unittests\": \"126e2b11b40ea87cb65b907687392f735f91b267\", \"cast_unittests\": \"465e2de4a3cab3728ba23c7cfa76a028482742ff\", \"cc_unittests\": \"1d71294a9ff509f5f32372143a8fb65b64adb8d5\", \"chrome_app_unittests\": \"53261a218b9abf752a664641521a0f58b839cff5\", \"chromedriver_unittests\": \"efadc503dc19167b80025e4db86cf593cca98c36\", \"components_browsertests\": \"64a409ffa10b422f0db41f83b1c9a8e02c520731\", \"components_unittests\": \"382ed10e1bb6235bea70f6bd76b25e3df2e4b01a\", \"compositor_unittests\": \"9f895c0dd2868caf4f5f0a0f8c030aa009fe554d\", \"content_browsertests\": \"d323c0b4a62e8a1a721892c88d1472d376153335\", \"content_shell_crash_test\": \"b992c87f37b206b6be2e8c0c79bf44dc7b732b33\", \"content_unittests\": \"6d7c2a127d0b2ef96222a93310600271c2450ad8\", \"crashpad_tests\": \"cac984c945cbf6f7dc7781448e6b591e2483edc7\", \"cronet_tests\": \"2936b48947cc68b5ebcc221f1a522e83eafd864f\", \"cronet_unittests\": \"26405eec6fdf81492cd5e621941b0b352f1701e9\", \"crypto_unittests\": \"ab56a15fa4e09b3c0b965c33675a2577453d78bf\", \"dbus_unittests\": \"84c4dff3925f67cd30fa0a97555595f347a67ca8\", \"device_unittests\": \"afca4cede044216d82408f7abe896c3a15bf37a2\", \"display_unittests\": \"9a91120501e655267549f4814b8401c1ae7f3747\", \"events_unittests\": \"3d699a58c010c3a00b130cb428908d53ab5494be\", \"extensions_browsertests\": \"7f1aff9ee742243733aac14708ced876f2fd5223\", \"extensions_unittests\": \"6a0d85efaefc04def03775d0ea021c499ea47866\", \"filesystem_service_unittests\": \"99c29e2b337972e9390d0d6efbc0770d0d8467ed\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"b85ba7b36190c27fe3f9d0c39c76d270301abb30\", \"gfx_unittests\": \"7df78548457d49dc1fffcf5700caf694b454760a\", \"gin_unittests\": \"6f5088e6e87e2bce9240ddd26550677d6598b06a\", \"google_apis_unittests\": \"d8b9daa30693b740335a3c876ac0e035abd53cd3\", \"gpu_unittests\": \"0d0321600e08c2002eacee1c70094b02fab2b770\", \"grit_python_unittests\": \"0a186e54539d3475bae4b9d19cc134d9a92e2108\", \"gwp_asan_unittests\": \"07223e118d9ad92e1d3a8c532b700b0a720fed09\", \"headless_browsertests\": \"2e68ebef3ccd51105b8adedad39e89b8e26001ec\", \"headless_unittests\": \"3e2b85bbec675bd2a66ddb1a3970cdd0f59ffd70\", \"interactive_ui_tests\": \"15c3f598f8891c0aa4b5387eef00fd906b2d1e6f\", \"ipc_tests\": \"7b7407d06fe23bf54b024974b2077c2958103121\", \"jingle_unittests\": \"7437a47d69123eb5d3c12ee74ba07547b100638c\", \"latency_unittests\": \"ec030e6504ab97229e8119b9bf1d52fedbad0629\", \"libjingle_xmpp_unittests\": \"64b3ad16211594845e3aa5a0f7cb1ca7c9a27c67\", \"media_blink_unittests\": \"ebc8c84f04e1a4f78d0868c6b393c231e11a2da2\", \"media_service_unittests\": \"b4351c76ba5f135e8316458e91860ba0de207a57\", \"media_unittests\": \"6bc293815b9a2957273267c1b9e92fe0da309ed8\", \"message_center_unittests\": \"8be79752748625c9a8f3c8afdec6dfbe8e393797\", \"metrics_python_tests\": \"667cbd518ed7c12ef808c074b552da5889790914\", \"midi_unittests\": \"b5897008b66758e6e7c3bbec99d73437a30c6a98\", \"mojo_core_unittests\": \"d2afda697258ebc3c22b885bf6c18188593f39e1\", \"mojo_unittests\": \"3af08aaa8336c30af095e6f4495e77746657ffc0\", \"nacl_helper_nonsfi_unittests\": \"9dad0cdf1df497baf07ecef7be5eb9bb122cbbc4\", \"nacl_loader_unittests\": \"4a89ba0575805d648860c4717b348b87314210a1\", \"native_theme_unittests\": \"1898fb32497486533a760196499a1d0869856d0c\", \"net_unittests\": \"21da8ac7ffb3e668ed1caea7b2f88f54a9da1a4a\", \"pdf_unittests\": \"0cd99f31d499f4226c2ea0a1968875db65d1666f\", \"perfetto_unittests\": \"16a1aa16394f7d0420398f8c436b16de89b9bb66\", \"ppapi_unittests\": \"6a45b9419685d77264ef1eb1e3274eb0a09eff91\", \"printing_unittests\": \"6c9da75c7e92affa5a41fd4e294702ce86784e1a\", \"remoting_unittests\": \"4555aea5ad1c06eef00fcf088ed59a68923d12f2\", \"sandbox_linux_unittests\": \"49333a7bacfab78ba5f30b5b83a585b4aba61dcc\", \"service_manager_unittests\": \"7f4a81aace07672a8afa4f6c8ec5baa8ff523e6f\", \"services_unittests\": \"126388367d8eea9cc2f0355c4f5544e15bd28ff3\", \"shell_dialogs_unittests\": \"88d7665027c96781c183e9a4a43df67fc5fc3e8e\", \"skia_unittests\": \"ec824f6df8451b69823b0a1683845df598c4cc5b\", \"snapshot_unittests\": \"6a05a419df2448c9d8f4293b820e01f1d4c9bc50\", \"sql_unittests\": \"17a985241baacb73b9c0b748806301ff4e7e3f64\", \"storage_unittests\": \"4c875959b0f04c4aef79dc95ee75ad13b13c132c\", \"sync_integration_tests\": \"1c6c29e21f90e3a900c56f2fe8fb473845bcb981\", \"telemetry_gpu_unittests\": \"bface9027f4697b43d8b77be2f7334889fd2b1d3\", \"telemetry_perf_unittests\": \"87f76e8928026a82dcd0eddedd16c6e2278d587f\", \"telemetry_unittests\": \"48d45a14afa1c690526bd6a7aac62a753ff79f45\", \"traffic_annotation_auditor_unittests\": \"4af659be5115c836d5e56cf2a1936014f59db766\", \"ui_base_unittests\": \"b124dc89e800bc4b759fd6272291aff89f1ec30f\", \"ui_touch_selection_unittests\": \"4a15ec7b876b9ee881b0ee8c23add20ecee7ecf5\", \"unit_tests\": \"01cd74c2497a184b572a40dd130e7c9c037d2bc9\", \"url_unittests\": \"879045635c6421053835295cc7efed35ca6298ca\", \"views_perftests\": \"412f3b80268d9b41c544cab5e7adea77c3e31d93\", \"views_unittests\": \"ee5ed4b0394524b5216443a04c27a853543cd27c\", \"viz_unittests\": \"879344dc3be1b9aa6db13b680a654baf4c9fe5e9\", \"vr_common_unittests\": \"1ee5fdefd5a0fc4aa08c66c6a0b8644bff39ce85\", \"vr_pixeltests\": \"919e77d96914f36921635e0b6cb20c8b781411da\", \"webdriver_wpt_tests\": \"903cd01f5d6b4039f41b989e0dfed2b4682f6b2c\", \"weblayer_browsertests\": \"108c1796b28ff0e6d88c1b8133701ebc8cbeb4c2\", \"wm_unittests\": \"6ad7684de66e5395fc8107779added177dc9d014\", \"wtf_unittests\": \"951e5c551367a72d7c4f2c6d724169aca1bf1678\", \"xr_browser_tests\": \"8d6c6811cccde0837d0d303bace5b9ef6e50bed5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_e47700e9abf1b62c06bb1feb4592b8e752d42e12f6359b4e93db4847c43379d6_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-east1-d-8-11-ugpr\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582082103959154",
"status": "COMPLETED",
"status_changed_ts": "1582085195900908",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168774",
"builder:Linux Builder (dbg)",
"buildset:commit/git/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48a8cf458b1a5b7f235695c37b396fc4b828ebee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053490713302748256",
"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/8888060651029264112/+/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:4a743ee032e46110",
"user_agent:luci-scheduler"
],
"updated_ts": "1582085195963226",
"url": "https://ci.chromium.org/b/8888060651029264112",
"utcnow_ts": "1582085196792835"
}
}
[04:06:36.809] Invocation finished in 55m41.700921455s with status SUCCEEDED