[06:16:48.878] New invocation is queued and will start shortly
[06:16:50.163] Starting the invocation (attempt 1)
[06:16:50.203] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:16:50.203] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:16:50.203] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058371253929511600",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"643e933c0d8a1f5a506e44f69a456217b9c788c7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9058371253929511600",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"gitiles_ref:refs/heads/master"
]
}
[06:16:52.249] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577427411685680",
"id": "8892941190323316640",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"643e933c0d8a1f5a506e44f69a456217b9c788c7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577427412135805",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166632",
"builder:Linux Builder (dbg)",
"buildset:commit/git/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058371253929511600",
"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/8892941190323316640/+/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": "1577427412135956",
"url": "https://ci.chromium.org/b/8892941190323316640",
"utcnow_ts": "1577427412241876"
}
}
[06:16:52.249] Task URL: https://ci.chromium.org/b/8892941190323316640
[06:16:52.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:2:0) after 1m0s
[06:17:52.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:2:0)
[06:17:52.266] Timer tick, asking Buildbucket for the build status
[06:17:52.910] Build 8892941190323316640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:52.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:3:0) after 1m0s
[06:18:53.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:3:0)
[06:18:53.115] Timer tick, asking Buildbucket for the build status
[06:18:53.414] Build 8892941190323316640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:53.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:4:0) after 1m0s
[06:19:53.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:4:0)
[06:19:53.445] Timer tick, asking Buildbucket for the build status
[06:19:53.625] Build 8892941190323316640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:53.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:5:0) after 1m0s
[06:20:53.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:5:0)
[06:20:53.726] Timer tick, asking Buildbucket for the build status
[06:20:53.993] Build 8892941190323316640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:53.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:6:0) after 1m0s
[06:21:12.539] Received PubSub notification, asking Buildbucket for the build status
[06:21:13.168] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:54.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:6:0)
[06:21:54.010] Timer tick, asking Buildbucket for the build status
[06:21:54.151] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:54.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:8:0) after 1m0s
[06:22:54.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:8:0)
[06:22:54.290] Timer tick, asking Buildbucket for the build status
[06:22:54.584] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:54.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:9:0) after 1m0s
[06:23:54.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:9:0)
[06:23:54.658] Timer tick, asking Buildbucket for the build status
[06:23:55.351] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:55.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:10:0) after 1m0s
[06:24:55.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:10:0)
[06:24:55.435] Timer tick, asking Buildbucket for the build status
[06:24:55.569] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:55.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:11:0) after 1m0s
[06:25:55.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:11:0)
[06:25:55.570] Timer tick, asking Buildbucket for the build status
[06:25:55.694] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:55.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:12:0) after 1m0s
[06:26:55.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:12:0)
[06:26:55.710] Timer tick, asking Buildbucket for the build status
[06:26:56.357] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:56.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:13:0) after 1m0s
[06:27:56.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:13:0)
[06:27:56.521] Timer tick, asking Buildbucket for the build status
[06:27:56.774] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:56.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:14:0) after 1m0s
[06:28:57.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:14:0)
[06:28:57.139] Timer tick, asking Buildbucket for the build status
[06:28:57.738] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:57.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:15:0) after 1m0s
[06:29:57.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:15:0)
[06:29:57.717] Timer tick, asking Buildbucket for the build status
[06:29:58.074] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:58.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:16:0) after 1m0s
[06:30:58.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:16:0)
[06:30:58.338] Timer tick, asking Buildbucket for the build status
[06:30:59.221] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:59.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:17:0) after 1m0s
[06:31:59.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:17:0)
[06:31:59.211] Timer tick, asking Buildbucket for the build status
[06:31:59.486] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:59.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:18:0) after 1m0s
[06:32:59.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:18:0)
[06:32:59.474] Timer tick, asking Buildbucket for the build status
[06:32:59.695] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:59.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:19:0) after 1m0s
[06:33:59.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:19:0)
[06:33:59.775] Timer tick, asking Buildbucket for the build status
[06:34:00.689] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:00.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:20:0) after 1m0s
[06:35:00.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:20:0)
[06:35:00.856] Timer tick, asking Buildbucket for the build status
[06:35:01.092] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:01.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:21:0) after 1m0s
[06:36:01.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:21:0)
[06:36:01.109] Timer tick, asking Buildbucket for the build status
[06:36:01.493] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:01.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:22:0) after 1m0s
[06:37:01.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:22:0)
[06:37:01.523] Timer tick, asking Buildbucket for the build status
[06:37:04.522] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:04.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:23:0) after 1m0s
[06:38:04.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:23:0)
[06:38:04.528] Timer tick, asking Buildbucket for the build status
[06:38:04.775] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:04.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:24:0) after 1m0s
[06:39:04.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:24:0)
[06:39:04.895] Timer tick, asking Buildbucket for the build status
[06:39:07.521] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:25:0) after 1m0s
[06:40:07.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:25:0)
[06:40:07.644] Timer tick, asking Buildbucket for the build status
[06:40:08.036] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:08.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:26:0) after 1m0s
[06:41:08.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:26:0)
[06:41:08.066] Timer tick, asking Buildbucket for the build status
[06:41:08.290] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:08.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:27:0) after 1m0s
[06:42:08.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:27:0)
[06:42:08.362] Timer tick, asking Buildbucket for the build status
[06:42:09.204] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:09.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:28:0) after 1m0s
[06:43:09.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:28:0)
[06:43:09.252] Timer tick, asking Buildbucket for the build status
[06:43:09.540] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:09.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:29:0) after 1m0s
[06:44:09.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:29:0)
[06:44:09.565] Timer tick, asking Buildbucket for the build status
[06:44:10.171] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:10.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:30:0) after 1m0s
[06:45:10.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:30:0)
[06:45:10.195] Timer tick, asking Buildbucket for the build status
[06:45:10.688] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:10.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:31:0) after 1m0s
[06:46:10.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:31:0)
[06:46:10.760] Timer tick, asking Buildbucket for the build status
[06:46:10.975] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:10.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:32:0) after 1m0s
[06:47:11.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:32:0)
[06:47:11.076] Timer tick, asking Buildbucket for the build status
[06:47:11.351] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:11.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:33:0) after 1m0s
[06:48:11.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:33:0)
[06:48:11.527] Timer tick, asking Buildbucket for the build status
[06:48:11.724] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:11.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:34:0) after 1m0s
[06:49:11.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:34:0)
[06:49:11.910] Timer tick, asking Buildbucket for the build status
[06:49:12.352] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:12.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:35:0) after 1m0s
[06:50:12.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:35:0)
[06:50:12.670] Timer tick, asking Buildbucket for the build status
[06:50:13.236] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:13.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:36:0) after 1m0s
[06:51:13.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:36:0)
[06:51:13.289] Timer tick, asking Buildbucket for the build status
[06:51:13.503] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:13.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:37:0) after 1m0s
[06:52:13.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:37:0)
[06:52:13.528] Timer tick, asking Buildbucket for the build status
[06:52:13.721] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:13.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:38:0) after 1m0s
[06:53:13.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:38:0)
[06:53:13.785] Timer tick, asking Buildbucket for the build status
[06:53:14.553] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:14.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:39:0) after 1m0s
[06:54:14.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:39:0)
[06:54:14.627] Timer tick, asking Buildbucket for the build status
[06:54:14.832] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:14.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:40:0) after 1m0s
[06:55:14.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:40:0)
[06:55:14.869] Timer tick, asking Buildbucket for the build status
[06:55:15.557] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:15.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:41:0) after 1m0s
[06:56:15.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:41:0)
[06:56:15.537] Timer tick, asking Buildbucket for the build status
[06:56:15.711] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:15.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:42:0) after 1m0s
[06:57:15.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:42:0)
[06:57:15.781] Timer tick, asking Buildbucket for the build status
[06:57:15.970] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:15.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:43:0) after 1m0s
[06:58:16.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:43:0)
[06:58:16.005] Timer tick, asking Buildbucket for the build status
[06:58:16.330] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:16.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:44:0) after 1m0s
[06:59:16.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:44:0)
[06:59:16.398] Timer tick, asking Buildbucket for the build status
[06:59:16.747] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:16.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:45:0) after 1m0s
[07:00:16.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:45:0)
[07:00:16.816] Timer tick, asking Buildbucket for the build status
[07:00:17.659] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:17.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:46:0) after 1m0s
[07:01:17.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:46:0)
[07:01:17.729] Timer tick, asking Buildbucket for the build status
[07:01:17.973] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:17.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:47:0) after 1m0s
[07:02:17.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:47:0)
[07:02:17.994] Timer tick, asking Buildbucket for the build status
[07:02:18.361] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:18.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:48:0) after 1m0s
[07:03:18.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:48:0)
[07:03:18.434] Timer tick, asking Buildbucket for the build status
[07:03:18.816] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:18.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:49:0) after 1m0s
[07:04:18.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:49:0)
[07:04:18.889] Timer tick, asking Buildbucket for the build status
[07:04:19.794] Build 8892941190323316640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:19.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058371253929511600:50:0) after 1m0s
[07:05:12.860] Received PubSub notification, asking Buildbucket for the build status
[07:05:13.171] Build 8892941190323316640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:05:13.171] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577430312229519",
"created_by": "project:chromium",
"created_ts": "1577427411685680",
"id": "8892941190323316640",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"643e933c0d8a1f5a506e44f69a456217b9c788c7\"}}",
"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-east1-d-8-0-ssf0\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166632, \"got_angle_revision\": \"01dd6f6ca430a5c5bfd9d237b5569abd835694fc\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"643e933c0d8a1f5a506e44f69a456217b9c788c7\", \"got_revision_cp\": \"refs/heads/master@{#727537}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"8c170824164c4917fb99a9c38b34609b152e949c\", \"got_v8_revision_cp\": \"refs/heads/8.1.76@{#1}\", \"got_webrtc_revision\": \"26762d0425ffd15af9ddc3ae669373668827ea00\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30125}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"643e933c0d8a1f5a506e44f69a456217b9c788c7\", \"swarm_hashes_refs/heads/master(at){#727537}_without_patch\": {\"accessibility_unittests\": \"dac92792f9431946ec9bf07fb662d4d471e66847\", \"angle_unittests\": \"6bf1b92fbd7b1f5c78006f76117fad48cca0d1c6\", \"app_shell_unittests\": \"ad9fddd916d5d12c599e3b774ca133489ee918df\", \"aura_unittests\": \"4df9d9cc8020b55272f6f7b3721fc9d1d70a0089\", \"base_unittests\": \"46495bb3640b367ecb288788ff4e462955c00faa\", \"base_util_unittests\": \"d75209d1deb1b5e9894d90fe49baad44f28198db\", \"blink_common_unittests\": \"d4200b27b46859d8cb381233a3c636176a82b71f\", \"blink_fuzzer_unittests\": \"880826d62ae30093578e5c8bce2f286ec672d204\", \"blink_heap_unittests\": \"fa51763a530503db9608e0f04b1973f110d83a9c\", \"blink_platform_unittests\": \"6a56d6c06c8b057b05eb1b951bb0e37b1c574b7b\", \"blink_python_tests\": \"45e2bce4fcf280281185ac44f79c46ad9c4d4512\", \"blink_unittests\": \"47b6c653877767a08da9c28a51f178656baab250\", \"blink_web_tests\": \"80a01af06c8f5ab25b117350204085f440516ab5\", \"boringssl_crypto_tests\": \"16bf76d0bd43020de0b0a3a27a0d178802347693\", \"boringssl_ssl_tests\": \"40be03876a4dfd4ccc8c18d1521e3ce976bda311\", \"browser_tests\": \"4bbfb631306bb2bae23c676c4047b267093b03a3\", \"cacheinvalidation_unittests\": \"556c60ab206bb104d474237a914ea13752f44a9a\", \"capture_unittests\": \"aed90ea5776100dd76ea44882ee086987f3cf5e9\", \"cast_unittests\": \"00626ba6caa0103e8542df354e89ab1a78bc730c\", \"cc_unittests\": \"b764dab6c37f0790a52bbb91862299e935fffd53\", \"chrome_app_unittests\": \"84fb7b19b3ddafcc42b8b0c8efd96b485a7c90c8\", \"chromedriver_unittests\": \"84cecfd4aeec404052e6929919da70de34e17adf\", \"components_browsertests\": \"8396b06654025f611c45d1bc1b35da6fd99884c9\", \"components_unittests\": \"3ba1e460df3708279f8d8f4ab8caa10b8288a3b8\", \"compositor_unittests\": \"0ce4869ca7a996e581b3dd5893bf67675b93df55\", \"content_browsertests\": \"628d0e4c51e692c0ec5b67ea7915ce8b8afb75d9\", \"content_shell_crash_test\": \"8f85594146002cea1f3312da72b8a31b58013454\", \"content_unittests\": \"d30643356df624fd5507d6501e3c7782afa17ce4\", \"crashpad_tests\": \"6483b36da3f759f43d4eacaca3c8f1037a31c56c\", \"cronet_tests\": \"d2fe87cb87e3fbe7289a6f9b1f052eba0caadcd2\", \"cronet_unittests\": \"e83c15295f8894bf3d40cb328012a8bf3aae0b00\", \"crypto_unittests\": \"62b85a206fae8f7fc117bfd87e24e01e6cfadaec\", \"dbus_unittests\": \"b18a20c9059f462936304c0128075027577884b4\", \"device_unittests\": \"9616776abba67a155c838c05545332cf3a119bd3\", \"devtools_lint_check\": \"f5ef4bbd5230ceca8e6b62aa06ad4d93f07aaee9\", \"devtools_type_check\": \"0560d4eae584ad288c2a1900ea29c456fa9b4b3b\", \"display_unittests\": \"412e63f43244814fd6c834e691bbf437dd046c8b\", \"events_unittests\": \"86555cf569256a85086d9a0ec2663aa3262fdc20\", \"extensions_browsertests\": \"fe4586c8eadd5b65f3d4bf304481c764dc9ad06a\", \"extensions_unittests\": \"3d3e4ce50c6aa05f365e94a221ff46d2e7eeddfa\", \"filesystem_service_unittests\": \"9aca8d246911257809c55eaca2c7b76049019b3f\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"173a0480b7a1b9ce885a333c8c994665573baf2f\", \"gfx_unittests\": \"1d383cfe080344ccf60203101b0ea7fdbb943569\", \"gin_unittests\": \"0fd8a7670e2bc9223fb9855e480b070faa43b96c\", \"google_apis_unittests\": \"47383a1b491154213e76ca123fe65da86bcf303a\", \"gpu_unittests\": \"d959ab665138455b0ef0aadf708d7a219e9bd112\", \"grit_python_unittests\": \"c651860184eae0fccc98981c3c79be6f65eaf3fe\", \"gwp_asan_unittests\": \"c5d91102ad9e99913ae55450637a2a25d69b8422\", \"headless_browsertests\": \"796f8f339e8a1df93ccf1a4e825f4cd88355f3eb\", \"headless_unittests\": \"a0ad17fb96e688f7fed693999f9247dd7d7f8bce\", \"interactive_ui_tests\": \"d17e2f165fade012bd9fe10bc41873b0b66c1b26\", \"ipc_tests\": \"faf77749ef75f8b62383be92292e7d0e7868cfed\", \"jingle_unittests\": \"c6cfc3cdb7297611ecea1dd365a915bf1d84cd4e\", \"latency_unittests\": \"5f8883eaf4bdf5c3788183e34aa8269701277462\", \"libjingle_xmpp_unittests\": \"940d78126a8ddca0dea8286598bb680270f85665\", \"media_blink_unittests\": \"dc7e2a71b582394526c9eb9c26d8457194ffcd20\", \"media_service_unittests\": \"9c1ced7b4d3f47f742568eccf140e05ec9ce8ba6\", \"media_unittests\": \"87f435c350d80cc8233780b219ca18379f7ac1f7\", \"message_center_unittests\": \"b8f1c95d13fdd49006cb207306b0ba067dd3a074\", \"metrics_python_tests\": \"6f878640850a1fd0ce6fe6e488075be8caf77a5b\", \"midi_unittests\": \"822878b6ce10fcd6b8a65a1034e688a4df68d121\", \"mojo_core_unittests\": \"74cad2c982308d7d83fd3c560a97045d57e06b78\", \"mojo_unittests\": \"b559a1cd5b201481086e37ab5035f7f1e9467af5\", \"nacl_helper_nonsfi_unittests\": \"55a89485b120e7f8bc5ce09509896d05a88460cc\", \"nacl_loader_unittests\": \"cd920aa6c45ad56576b8d9ddb8e0365a5fe77013\", \"native_theme_unittests\": \"271cdef464313246f498683e7957056890a62cab\", \"net_unittests\": \"8acb79454a04d6356def0845ff71d9aa09c1d4ac\", \"pdf_unittests\": \"9eb2d30ee8ad95409404a0186c19bbbd35144d27\", \"perfetto_unittests\": \"345c16c5db78b7f517493db9f4fbbe342d28b908\", \"ppapi_unittests\": \"63543fd7c87aebb78b3c97785249e2940ef460eb\", \"printing_unittests\": \"aab6f92bdcad9789445422b8601d96541f43db26\", \"remoting_unittests\": \"0b493b6d72724916cf268aa9d28e520ad5d16ca5\", \"sandbox_linux_unittests\": \"4086d03e75d59c4b049a5feaa15fbff78aab120f\", \"service_manager_unittests\": \"6a641610eaa44c4a003aa523ae9021294e82e693\", \"services_unittests\": \"c1c51d47d31931a1810fb60f987c363fab573526\", \"shell_dialogs_unittests\": \"469364bb7e86b752c0ee776f47d5624681388076\", \"skia_unittests\": \"8f4086dfe77741a3c0b809b49e621c16c86a5b86\", \"snapshot_unittests\": \"4b11ec4d8c8ab41342550036597fff1bd2125376\", \"sql_unittests\": \"ec308b65259310647da2da207a5966f418f05f53\", \"storage_unittests\": \"619c1f7aa4c2145f9e253ff895ae09f75205a65f\", \"sync_integration_tests\": \"57b33a9724184e2f1fecc772b2e2b9e1c2d948db\", \"telemetry_gpu_unittests\": \"c8ac46ccc851c0fe524eaa1da790e954924ac9ec\", \"telemetry_perf_unittests\": \"9640ce2464960f344fbd323755324761541fdbf8\", \"telemetry_unittests\": \"cb998988c8b81228b146ea0aee34e36f4e31700a\", \"traffic_annotation_auditor_unittests\": \"5fa370b59d7285eb057f481c4be6bcce97e9bf78\", \"ui_base_unittests\": \"524cee00d90541d39237b4f655e595d8ee866c07\", \"ui_touch_selection_unittests\": \"229370e127360908d752482ff4120d8efef1dc9b\", \"unit_tests\": \"811db50c081409198a6976a4521229fcbf7ea6c7\", \"url_unittests\": \"ba92c2fc91c35ef49260c33ff6d960cd3cde154d\", \"views_perftests\": \"34f67f699b60644fee8f2e82b4945f0deb2fdcea\", \"views_unittests\": \"055a3c18232bca53d1fb1a38a727a2cd4cb7e2bf\", \"viz_unittests\": \"f1ede07d0e380aa3fb0b1fe110741b86fd5deaf8\", \"vr_common_unittests\": \"78cf69c9ad82d95abe2c5446fe4616283689f65b\", \"vr_pixeltests\": \"02797377a19151ede7216a46fe3079b8be619eb0\", \"webdriver_wpt_tests\": \"fdd89e597f7c907e3d63cced38817c35f492b158\", \"weblayer_browsertests\": \"b9822cacdf08a5b1c3b276c706a23fdb85e4b5b1\", \"wm_unittests\": \"11f541b09b800855c90d4fcf3dd363f750079a23\", \"wtf_unittests\": \"ea10745fc8b3ae4b3898431d0cfccbe841019105\", \"xr_browser_tests\": \"6d6bc039040b0172db255de0ea723dae15722c19\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_5c21095a1a129131be723eb555273fa4f1dc89f7e6d0ed0ea2c09e97b0cf5fcb_v2\", \"builder_a3249012ab2e105b4f1a10f0dc352b422f692fd701d889292e5c6170d198db4b_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-east1-d-8-0-ssf0\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577427671759621",
"status": "COMPLETED",
"status_changed_ts": "1577430312515542",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166632",
"builder:Linux Builder (dbg)",
"buildset:commit/git/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/643e933c0d8a1f5a506e44f69a456217b9c788c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058371253929511600",
"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/8892941190323316640/+/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:495ed1ae881bc410",
"user_agent:luci-scheduler"
],
"updated_ts": "1577430312522138",
"url": "https://ci.chromium.org/b/8892941190323316640",
"utcnow_ts": "1577430313155209"
}
}
[07:05:13.171] Invocation finished in 48m24.309482356s with status SUCCEEDED