[23:31:02.120] New invocation is queued and will start shortly
[23:31:03.678] Starting the invocation (attempt 1)
[23:31:03.776] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:31:03.776] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:31:03.776] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060571110553026064",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060571110553026064",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"gitiles_ref:refs/heads/master"
]
}
[23:31:05.079] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1575329464051827",
"id": "8895141047861122544",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575329464525116",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165573",
"builder:Linux Builder (dbg)",
"buildset:commit/git/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060571110553026064",
"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/8895141047861122544/+/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": "1575329464525327",
"url": "https://ci.chromium.org/b/8895141047861122544",
"utcnow_ts": "1575329465025800"
}
}
[23:31:05.079] Task URL: https://ci.chromium.org/b/8895141047861122544
[23:31:05.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:2:0) after 1m0s
[23:31:15.763] Received PubSub notification, asking Buildbucket for the build status
[23:31:16.276] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:05.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:2:0)
[23:32:05.199] Timer tick, asking Buildbucket for the build status
[23:32:05.937] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:05.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:4:0) after 1m0s
[23:33:06.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:4:0)
[23:33:06.108] Timer tick, asking Buildbucket for the build status
[23:33:07.209] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:07.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:5:0) after 1m0s
[23:34:07.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:5:0)
[23:34:07.258] Timer tick, asking Buildbucket for the build status
[23:34:07.729] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:07.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:6:0) after 1m0s
[23:35:07.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:6:0)
[23:35:07.866] Timer tick, asking Buildbucket for the build status
[23:35:09.342] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:09.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:7:0) after 1m0s
[23:36:09.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:7:0)
[23:36:09.416] Timer tick, asking Buildbucket for the build status
[23:36:09.989] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:8:0) after 1m0s
[23:37:10.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:8:0)
[23:37:10.099] Timer tick, asking Buildbucket for the build status
[23:37:10.764] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:9:0) after 1m0s
[23:38:10.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:9:0)
[23:38:10.798] Timer tick, asking Buildbucket for the build status
[23:38:11.220] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:11.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:10:0) after 1m0s
[23:39:11.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:10:0)
[23:39:11.315] Timer tick, asking Buildbucket for the build status
[23:39:11.492] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:11.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:11:0) after 1m0s
[23:40:11.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:11:0)
[23:40:11.512] Timer tick, asking Buildbucket for the build status
[23:40:11.750] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:11.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:12:0) after 1m0s
[23:41:11.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:12:0)
[23:41:11.774] Timer tick, asking Buildbucket for the build status
[23:41:12.109] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:12.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:13:0) after 1m0s
[23:42:12.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:13:0)
[23:42:12.331] Timer tick, asking Buildbucket for the build status
[23:42:12.873] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:12.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:14:0) after 1m0s
[23:43:13.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:14:0)
[23:43:13.185] Timer tick, asking Buildbucket for the build status
[23:43:13.466] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:13.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:15:0) after 1m0s
[23:44:13.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:15:0)
[23:44:13.878] Timer tick, asking Buildbucket for the build status
[23:44:14.236] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:14.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:16:0) after 1m0s
[23:45:14.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:16:0)
[23:45:14.442] Timer tick, asking Buildbucket for the build status
[23:45:14.646] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:14.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:17:0) after 1m0s
[23:46:14.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:17:0)
[23:46:14.716] Timer tick, asking Buildbucket for the build status
[23:46:15.402] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:15.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:18:0) after 1m0s
[23:47:15.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:18:0)
[23:47:15.586] Timer tick, asking Buildbucket for the build status
[23:47:15.790] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:15.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:19:0) after 1m0s
[23:48:16.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:19:0)
[23:48:16.151] Timer tick, asking Buildbucket for the build status
[23:48:16.378] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:16.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:20:0) after 1m0s
[23:49:16.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:20:0)
[23:49:16.848] Timer tick, asking Buildbucket for the build status
[23:49:17.244] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:17.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:21:0) after 1m0s
[23:50:17.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:21:0)
[23:50:17.268] Timer tick, asking Buildbucket for the build status
[23:50:17.461] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:17.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:22:0) after 1m0s
[23:51:17.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:22:0)
[23:51:17.593] Timer tick, asking Buildbucket for the build status
[23:51:18.244] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:18.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:23:0) after 1m0s
[23:52:18.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:23:0)
[23:52:18.297] Timer tick, asking Buildbucket for the build status
[23:52:19.483] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:19.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:24:0) after 1m0s
[23:53:19.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:24:0)
[23:53:19.547] Timer tick, asking Buildbucket for the build status
[23:53:21.937] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:21.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:25:0) after 1m0s
[23:54:22.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:25:0)
[23:54:22.061] Timer tick, asking Buildbucket for the build status
[23:54:22.708] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:22.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:26:0) after 1m0s
[23:55:22.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:26:0)
[23:55:22.792] Timer tick, asking Buildbucket for the build status
[23:55:23.103] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:23.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:27:0) after 1m0s
[23:56:23.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:27:0)
[23:56:23.152] Timer tick, asking Buildbucket for the build status
[23:56:23.596] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:23.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:28:0) after 1m0s
[23:57:23.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:28:0)
[23:57:23.761] Timer tick, asking Buildbucket for the build status
[23:57:23.958] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:23.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:29:0) after 1m0s
[23:58:23.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:29:0)
[23:58:23.971] Timer tick, asking Buildbucket for the build status
[23:58:24.391] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:24.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:30:0) after 1m0s
[23:59:24.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:30:0)
[23:59:24.446] Timer tick, asking Buildbucket for the build status
[23:59:24.753] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:24.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:31:0) after 1m0s
[00:00:24.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:31:0)
[00:00:24.822] Timer tick, asking Buildbucket for the build status
[00:00:25.117] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:32:0) after 1m0s
[00:01:25.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:32:0)
[00:01:25.145] Timer tick, asking Buildbucket for the build status
[00:01:25.396] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:25.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:33:0) after 1m0s
[00:02:25.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:33:0)
[00:02:25.416] Timer tick, asking Buildbucket for the build status
[00:02:25.641] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:25.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:34:0) after 1m0s
[00:03:25.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:34:0)
[00:03:25.675] Timer tick, asking Buildbucket for the build status
[00:03:26.166] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:35:0) after 1m0s
[00:04:26.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:35:0)
[00:04:26.192] Timer tick, asking Buildbucket for the build status
[00:04:27.415] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:27.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:36:0) after 1m0s
[00:05:27.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:36:0)
[00:05:27.422] Timer tick, asking Buildbucket for the build status
[00:05:27.994] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:27.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:37:0) after 1m0s
[00:06:28.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:37:0)
[00:06:28.112] Timer tick, asking Buildbucket for the build status
[00:06:28.294] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:28.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:38:0) after 1m0s
[00:07:28.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:38:0)
[00:07:28.389] Timer tick, asking Buildbucket for the build status
[00:07:28.621] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:28.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:39:0) after 1m0s
[00:08:28.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:39:0)
[00:08:28.616] Timer tick, asking Buildbucket for the build status
[00:08:28.863] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:28.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:40:0) after 1m0s
[00:09:29.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:40:0)
[00:09:29.039] Timer tick, asking Buildbucket for the build status
[00:09:31.334] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:41:0) after 1m0s
[00:10:31.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:41:0)
[00:10:31.436] Timer tick, asking Buildbucket for the build status
[00:10:31.722] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:31.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:42:0) after 1m0s
[00:11:31.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:42:0)
[00:11:31.779] Timer tick, asking Buildbucket for the build status
[00:11:32.525] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:32.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:43:0) after 1m0s
[00:12:32.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:43:0)
[00:12:32.645] Timer tick, asking Buildbucket for the build status
[00:12:32.879] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:32.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:44:0) after 1m0s
[00:13:32.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:44:0)
[00:13:32.989] Timer tick, asking Buildbucket for the build status
[00:13:33.229] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:33.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:45:0) after 1m0s
[00:14:33.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:45:0)
[00:14:33.297] Timer tick, asking Buildbucket for the build status
[00:14:33.554] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:33.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:46:0) after 1m0s
[00:15:33.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:46:0)
[00:15:33.593] Timer tick, asking Buildbucket for the build status
[00:15:37.028] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:37.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:47:0) after 1m0s
[00:16:37.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:47:0)
[00:16:37.074] Timer tick, asking Buildbucket for the build status
[00:16:37.428] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:48:0) after 1m0s
[00:17:37.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:48:0)
[00:17:37.457] Timer tick, asking Buildbucket for the build status
[00:17:37.733] Build 8895141047861122544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:37.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060571110553026064:49:0) after 1m0s
[00:18:25.466] Received PubSub notification, asking Buildbucket for the build status
[00:18:25.982] Build 8895141047861122544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:18:25.982] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1575332304500385",
"created_by": "project:chromium",
"created_ts": "1575329464051827",
"id": "8895141047861122544",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6\"}}",
"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-46-bvuu\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165573, \"got_angle_revision\": \"ca1b0fb895ca86ce6300cf365dce7b10c395c559\", \"got_dawn_revision\": \"969df2b3a21c126b2e0015ce2392c135f32a6a08\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6\", \"got_revision_cp\": \"refs/heads/master@{#720709}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b64fbfec4dcd3f81c776198641b1fc71ac8d64a4\", \"got_v8_revision\": \"adfb6ba32d881a5bba73f9c7121ca9f8dba881b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.418@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6\", \"swarm_hashes_refs/heads/master(at){#720709}_without_patch\": {\"accessibility_unittests\": \"e2ad3adf7341e2fdd576f2cea2d0d04e9cf12731\", \"angle_unittests\": \"9e3ac02a3198846a937bf4329d57e2d01e16dc75\", \"app_shell_unittests\": \"6f04d52fc9b660a4fcb9b1eecc8738781808692a\", \"aura_unittests\": \"a48e4b50a82d9e9601ee86267d2ebbbecce1d33c\", \"base_unittests\": \"11595fcb7ebef803dc34dc7d645df7128603df7d\", \"base_util_unittests\": \"711415c2cb60eca6431289a233d6535a769ead28\", \"blink_common_unittests\": \"26d4a28e522d6b02c9c15ff39c4800b995e484fc\", \"blink_fuzzer_unittests\": \"ad6691ba7e0b9f8221e42817320f042eeaaa27da\", \"blink_heap_unittests\": \"1b847047b2b684875f3fa89f83bf6271f2df1f59\", \"blink_platform_unittests\": \"2c45140e10b82424a01b88324e84c9e6785f6ef2\", \"blink_python_tests\": \"1c53bc753a5c1bd67077be020721ef6f805f668f\", \"blink_unittests\": \"cc24e794ca3e86be9ad1371c75a87f966e2e3d77\", \"blink_web_tests_exparchive\": \"2846a0bce253bbe3f884a16030fcc1c20109e3a6\", \"boringssl_crypto_tests\": \"dc03e0ed597ef9c6366ed8f168258cf6cc250165\", \"boringssl_ssl_tests\": \"f064396effa1e356ec34bd41aeafa1a843fbb85d\", \"browser_tests\": \"1d9f1283b148c0f33ae653b574b70ed74379dfd9\", \"cacheinvalidation_unittests\": \"dd51a52db5e3b7799627e68e28cc8bb55beedfe4\", \"capture_unittests\": \"77e0006744d0182e35fc0b4b224a603fcd31a10e\", \"cast_unittests\": \"2f35363f65ca031135becd010a7cc5bdc49d8e4b\", \"cc_unittests\": \"b922f1dea6b9e01f51cae24498449211608890d6\", \"chrome_app_unittests\": \"c486252d0311d8410f00e6a5cab1b973e0170b39\", \"chromedriver_unittests\": \"0c4f3ac94fa95024be7694bb69311e216e595922\", \"color_unittests\": \"be7629a20381952960984a369c93ae7c6ad0f6fa\", \"components_browsertests\": \"202ed0e0e46202bafb09d7dccffa3fc01977f1ad\", \"components_unittests\": \"1a00536a62b05a28761d0a56876906803d00bd88\", \"compositor_unittests\": \"5791abc440985f1fec3c68c0e2d95b0d1b0c3fe7\", \"content_browsertests\": \"4270d01ce9a303238320e28bc3781e72bc04a859\", \"content_shell_crash_test\": \"845cb49fa00f836207c988c8c2351c6d14374aa4\", \"content_unittests\": \"e2a511f57c8c87384a1aa47f168f6dceeee5e3a6\", \"crashpad_tests\": \"5916dc962117a46311ea5f0a766119e00ca337e7\", \"cronet_tests\": \"5b56977c814f6daa4e4bcf76ad9e9671d95a2001\", \"cronet_unittests\": \"d8a57420273d67fd7fe9e386615634420a563d29\", \"crypto_unittests\": \"27a9b77e993645c8ddb24173afdbcf4bcc15cc58\", \"dbus_unittests\": \"2e100c305b0ebd6deb8ce8972e6db03e3962587c\", \"device_unittests\": \"d453893e62704bff28b423629601c7fa5cf65119\", \"devtools_lint_check\": \"549bc078ae1f84ede47ba3b3c871aecf10475756\", \"devtools_type_check\": \"3d62b7936f7e1fac82fa89b9e14e2a3c63b63456\", \"display_unittests\": \"0d0af195d6891d59143e934ad65432fbf129aaf5\", \"events_unittests\": \"ac98a9d986ec13ef0d424698e40b3fcfcb021a64\", \"extensions_browsertests\": \"e68fe1ae3507ae1fe0fc1beb914215afcd46142b\", \"extensions_unittests\": \"126749d6dbf4dd6070f220a89adbc0179126bb1b\", \"filesystem_service_unittests\": \"bbc5ab61b2489e5e644b022990af8570867584d5\", \"flatbuffers_unittests\": \"6a9e0c8cd5569a4a962d55707cc8c4c160d8ad1e\", \"gcm_unit_tests\": \"de1dde418e689d34dbe3f54f98e545232c72a35c\", \"gfx_unittests\": \"84a3cbc1ee28c4edce7052f42759fe919c6d82d9\", \"gin_unittests\": \"63a1155188932a18d7ae08cefe4404dcbd7f9f7c\", \"google_apis_unittests\": \"a0d84457a4670ccc4927e04de3182044d41fd083\", \"gpu_unittests\": \"b0856fcabb0106243c6b5ac29473e3afdebe5046\", \"grit_python_unittests\": \"3e00f12fad77d025ae19c481a4bea2de4484d0b4\", \"gwp_asan_unittests\": \"e940b158e7eed42011d4c2e4b6f5ace57d61427f\", \"headless_browsertests\": \"5aadcdcb4d4da59ddfabc6b63ec325dbf4d1148f\", \"headless_unittests\": \"2d51e67cb68cde0c431991cc0fa2191534d4eaea\", \"interactive_ui_tests\": \"a27d1c83aab97edd5e4ebd5c8d1b393c55326d9b\", \"ipc_tests\": \"8955e1c944aac43edf4192f6b43dd16c56a28ab2\", \"jingle_unittests\": \"c1871e40e7acf0ecdb1a6ff53bddd53a1326c8a1\", \"latency_unittests\": \"096844c145c9c93f3b1ad057da223496ba5b4ee4\", \"libjingle_xmpp_unittests\": \"7011fcf9dd33ddbf7ede2a5530471a767b4c4cf0\", \"media_blink_unittests\": \"ac3d95de517838e6bc48fe00134289bbda3e9b17\", \"media_service_unittests\": \"7469ff6a5477b9d1d26353381017d6c0d9e0568d\", \"media_unittests\": \"ac3852cc53e01859bdf28e16e820f6547fab9f01\", \"message_center_unittests\": \"1ccc58d40093aed9ff48451c798ed0d1afaf0ea2\", \"metrics_python_tests\": \"11ecffd0d0e0767eb99f0da7689aa07d11192bbf\", \"midi_unittests\": \"ef098e698b89c33ab6fdbc0cae9f35142b192dc5\", \"mojo_core_unittests\": \"4add03ca9e1ed8edba0b9b9f0d775bbc241f6374\", \"mojo_unittests\": \"caaf95c66f7c26dbc496e81cf6199d13b2d1841e\", \"nacl_helper_nonsfi_unittests\": \"a017ad7fb2529a685eaee0c97106ef1e2489813b\", \"nacl_loader_unittests\": \"58bd292db42359b174b603eeee459a0fd132fe9a\", \"native_theme_unittests\": \"1a96cfad89383e8f925a8da4d119440474dd6ec4\", \"net_unittests\": \"025393aa61d03a1e020c8b5bd076a14d6c38fc11\", \"pdf_unittests\": \"e61f9de825a5ae7b4fc7db589f542f29ee9783bd\", \"perfetto_unittests\": \"cf76f22d6e65bc204ba99cc759a683f3c76a1567\", \"ppapi_unittests\": \"6d7a5d3da7fa08eb6cdd6bd77e37345e7f3c68c1\", \"printing_unittests\": \"8192c9749b2c03b17c90927fcc33f296b62ff451\", \"remoting_unittests\": \"980bc072f1bf23ac7d83530158b334bc1b436bdd\", \"sandbox_linux_unittests\": \"ac7104ca6db12e3c0c4f03691418d2051bc2702b\", \"service_manager_unittests\": \"153227faaeaece63e5c35df8fdc486fe2598468e\", \"services_unittests\": \"4503c2d5ad6d1a0c77a3447f5e2bbf759dbb713b\", \"shell_dialogs_unittests\": \"fea7ba4be13f54f6e737e05be2d6a7bc239644ee\", \"skia_unittests\": \"3bdb4504605ed07d4ac762dbc7f046d984c67f3f\", \"snapshot_unittests\": \"297730dcf378dd2d47c6608176118a489eff7393\", \"sql_unittests\": \"7d4d7f49fd28c21f967d6dff98d0e80cc82a1e66\", \"storage_unittests\": \"b41f5c4c7d1075b8391c2e9f9e22ce3fbd5ca420\", \"sync_integration_tests\": \"86674c03754fbbfc72163ef7cea8217f5c340c9c\", \"telemetry_gpu_unittests\": \"319d95cdd996458aef8c72e155904186eb6a8c02\", \"telemetry_perf_unittests\": \"4010c51ec53d3ce4821beef536cdba8cd9a306bd\", \"telemetry_unittests\": \"5b3f1b55b3009544bfbf4e83727afb12fc21aade\", \"traffic_annotation_auditor_unittests\": \"31af97434946f1f83e4c566456237122450b1a0d\", \"ui_base_unittests\": \"ac80b996e0ee6d79c53aa602f020310b8767767f\", \"ui_touch_selection_unittests\": \"bd3c4b35a16f1f0ed3bd3701f21e1e71e1f33db4\", \"unit_tests\": \"a2067a83860f7ca20b6f3c84556ec1761cfe7c40\", \"url_unittests\": \"c21657ec879512c491f3a3df75653a86e5c7c815\", \"views_perftests\": \"51e35fb2e432ef65a84b90a5914eb7ef4d0c5126\", \"views_unittests\": \"ae4239b08ba826460458238f504e5e8c8a1616a8\", \"viz_unittests\": \"d1f1ec24872b02351192a9c61e040ae7903eb80b\", \"vr_common_unittests\": \"efb7058b9913c8072a457f28ef2d026fce2095a0\", \"vr_pixeltests\": \"ce343ad60a199b1737e3716b9a77e76c1356d28a\", \"webdriver_wpt_tests\": \"7b62775d95e757460b05ed2cf5613815691b9412\", \"weblayer_browsertests\": \"215ecbbac5e18f4950b922de241b33e78ef435c3\", \"wm_unittests\": \"5ec7a04667216dfa74a6fbacf4dca3541176354f\", \"wtf_unittests\": \"57c62230d38fd78e4337976211fb04dfcc01f225\", \"xr_browser_tests\": \"85d8937f9c19ac0b238ec711013e00e7bb159713\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_a7ee5da0df0016658701d083d0522e25adae25ba2fa23a313caa54097831117f_v2\", \"builder_b9c3693fc2545c15d2b05658613aaabe013e89ffda116be9a8beaa7c527588c2_v2\", \"builder_de45c485d8a81e16b8ff53eb76d94467eed5e11e118465311a13e72e2b141cb1_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-46-bvuu\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4679-6acb960\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575329474750804",
"status": "COMPLETED",
"status_changed_ts": "1575332305001213",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165573",
"builder:Linux Builder (dbg)",
"buildset:commit/git/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95fb6898ee7bc8e7c83edfc1ddd6f7c7ccbe1ab6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060571110553026064",
"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/8895141047861122544/+/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:48e1c5abde24f510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575332305006557",
"url": "https://ci.chromium.org/b/8895141047861122544",
"utcnow_ts": "1575332305953317"
}
}
[00:18:25.982] Invocation finished in 47m23.88156512s with status SUCCEEDED