[06:45:04.379] New invocation is queued and will start shortly
[06:45:05.756] Starting the invocation (attempt 1)
[06:45:05.790] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:45:05.790] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:45:05.790] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056738730682108912",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49961139306e66538e8fe2e850ef4aeeffcfc6f1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056738730682108912",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"gitiles_ref:refs/heads/master"
]
}
[06:45:06.817] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578984305949823",
"id": "8891308668363230320",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49961139306e66538e8fe2e850ef4aeeffcfc6f1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578984306615824",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167352",
"builder:Linux Builder (dbg)",
"buildset:commit/git/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056738730682108912",
"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/8891308668363230320/+/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": "1578984306616004",
"url": "https://ci.chromium.org/b/8891308668363230320",
"utcnow_ts": "1578984306808162"
}
}
[06:45:06.817] Task URL: https://ci.chromium.org/b/8891308668363230320
[06:45:06.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:2:0) after 1m0s
[06:46:06.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:2:0)
[06:46:06.881] Timer tick, asking Buildbucket for the build status
[06:46:07.372] Build 8891308668363230320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:07.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:3:0) after 1m0s
[06:47:07.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:3:0)
[06:47:07.403] Timer tick, asking Buildbucket for the build status
[06:47:07.561] Build 8891308668363230320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:07.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:4:0) after 1m0s
[06:48:07.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:4:0)
[06:48:07.701] Timer tick, asking Buildbucket for the build status
[06:48:07.900] Build 8891308668363230320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:07.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:5:0) after 1m0s
[06:49:08.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:5:0)
[06:49:08.007] Timer tick, asking Buildbucket for the build status
[06:49:08.252] Build 8891308668363230320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:08.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:6:0) after 1m0s
[06:50:08.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:6:0)
[06:50:08.300] Timer tick, asking Buildbucket for the build status
[06:50:08.580] Build 8891308668363230320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:08.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:7:0) after 1m0s
[06:50:15.682] Received PubSub notification, asking Buildbucket for the build status
[06:50:16.852] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:08.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:7:0)
[06:51:08.697] Timer tick, asking Buildbucket for the build status
[06:51:09.296] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:09.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:9:0) after 1m0s
[06:52:09.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:9:0)
[06:52:09.405] Timer tick, asking Buildbucket for the build status
[06:52:09.944] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:09.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:10:0) after 1m0s
[06:53:10.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:10:0)
[06:53:10.092] Timer tick, asking Buildbucket for the build status
[06:53:13.764] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:13.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:11:0) after 1m0s
[06:54:13.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:11:0)
[06:54:13.821] Timer tick, asking Buildbucket for the build status
[06:54:14.066] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:14.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:12:0) after 1m0s
[06:55:14.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:12:0)
[06:55:14.065] Timer tick, asking Buildbucket for the build status
[06:55:14.212] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:14.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:13:0) after 1m0s
[06:56:14.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:13:0)
[06:56:14.303] Timer tick, asking Buildbucket for the build status
[06:56:14.941] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:14.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:14:0) after 1m0s
[06:57:14.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:14:0)
[06:57:14.961] Timer tick, asking Buildbucket for the build status
[06:57:15.165] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:15.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:15:0) after 1m0s
[06:58:15.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:15:0)
[06:58:15.263] Timer tick, asking Buildbucket for the build status
[06:58:15.476] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:16:0) after 1m0s
[06:59:15.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:16:0)
[06:59:15.695] Timer tick, asking Buildbucket for the build status
[06:59:18.867] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:18.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:17:0) after 1m0s
[07:00:19.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:17:0)
[07:00:19.030] Timer tick, asking Buildbucket for the build status
[07:00:19.955] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:19.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:18:0) after 1m0s
[07:01:20.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:18:0)
[07:01:20.013] Timer tick, asking Buildbucket for the build status
[07:01:20.561] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:20.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:19:0) after 1m0s
[07:02:20.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:19:0)
[07:02:20.611] Timer tick, asking Buildbucket for the build status
[07:02:20.846] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:20.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:20:0) after 1m0s
[07:03:21.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:20:0)
[07:03:21.069] Timer tick, asking Buildbucket for the build status
[07:03:21.382] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:21.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:21:0) after 1m0s
[07:04:21.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:21:0)
[07:04:21.549] Timer tick, asking Buildbucket for the build status
[07:04:21.749] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:21.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:22:0) after 1m0s
[07:05:21.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:22:0)
[07:05:21.853] Timer tick, asking Buildbucket for the build status
[07:05:22.200] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:22.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:23:0) after 1m0s
[07:06:22.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:23:0)
[07:06:22.482] Timer tick, asking Buildbucket for the build status
[07:06:22.851] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:22.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:24:0) after 1m0s
[07:07:22.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:24:0)
[07:07:22.873] Timer tick, asking Buildbucket for the build status
[07:07:23.324] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:23.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:25:0) after 1m0s
[07:08:23.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:25:0)
[07:08:23.460] Timer tick, asking Buildbucket for the build status
[07:08:23.582] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:23.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:26:0) after 1m0s
[07:09:23.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:26:0)
[07:09:23.946] Timer tick, asking Buildbucket for the build status
[07:09:27.011] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:27.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:27:0) after 1m0s
[07:10:27.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:27:0)
[07:10:27.035] Timer tick, asking Buildbucket for the build status
[07:10:27.249] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:27.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:28:0) after 1m0s
[07:11:27.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:28:0)
[07:11:27.360] Timer tick, asking Buildbucket for the build status
[07:11:27.594] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:27.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:29:0) after 1m0s
[07:12:27.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:29:0)
[07:12:27.780] Timer tick, asking Buildbucket for the build status
[07:12:28.045] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:28.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:30:0) after 1m0s
[07:13:28.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:30:0)
[07:13:28.148] Timer tick, asking Buildbucket for the build status
[07:13:28.334] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:28.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:31:0) after 1m0s
[07:14:28.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:31:0)
[07:14:28.610] Timer tick, asking Buildbucket for the build status
[07:14:28.753] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:28.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:32:0) after 1m0s
[07:15:28.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:32:0)
[07:15:28.893] Timer tick, asking Buildbucket for the build status
[07:15:29.093] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:29.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:33:0) after 1m0s
[07:16:29.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:33:0)
[07:16:29.201] Timer tick, asking Buildbucket for the build status
[07:16:29.437] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:34:0) after 1m0s
[07:17:29.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:34:0)
[07:17:29.637] Timer tick, asking Buildbucket for the build status
[07:17:30.489] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:30.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:35:0) after 1m0s
[07:18:30.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:35:0)
[07:18:30.679] Timer tick, asking Buildbucket for the build status
[07:18:31.112] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:31.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:36:0) after 1m0s
[07:19:31.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:36:0)
[07:19:31.420] Timer tick, asking Buildbucket for the build status
[07:19:32.338] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:32.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:37:0) after 1m0s
[07:20:32.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:37:0)
[07:20:32.519] Timer tick, asking Buildbucket for the build status
[07:20:33.469] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:33.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:38:0) after 1m0s
[07:21:33.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:38:0)
[07:21:33.532] Timer tick, asking Buildbucket for the build status
[07:21:34.648] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:34.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:39:0) after 1m0s
[07:22:34.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:39:0)
[07:22:34.709] Timer tick, asking Buildbucket for the build status
[07:22:35.446] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:35.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:40:0) after 1m0s
[07:23:35.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:40:0)
[07:23:35.484] Timer tick, asking Buildbucket for the build status
[07:23:35.816] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:35.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:41:0) after 1m0s
[07:24:35.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:41:0)
[07:24:35.866] Timer tick, asking Buildbucket for the build status
[07:24:36.073] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:36.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:42:0) after 1m0s
[07:25:36.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:42:0)
[07:25:36.162] Timer tick, asking Buildbucket for the build status
[07:25:36.300] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:36.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:43:0) after 1m0s
[07:26:36.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:43:0)
[07:26:36.365] Timer tick, asking Buildbucket for the build status
[07:26:37.033] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:37.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:44:0) after 1m0s
[07:27:37.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:44:0)
[07:27:37.216] Timer tick, asking Buildbucket for the build status
[07:27:37.419] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:37.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:45:0) after 1m0s
[07:28:37.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:45:0)
[07:28:37.597] Timer tick, asking Buildbucket for the build status
[07:28:38.119] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:46:0) after 1m0s
[07:29:38.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:46:0)
[07:29:38.271] Timer tick, asking Buildbucket for the build status
[07:29:38.513] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:38.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:47:0) after 1m0s
[07:30:38.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:47:0)
[07:30:38.695] Timer tick, asking Buildbucket for the build status
[07:30:39.097] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:39.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:48:0) after 1m0s
[07:31:39.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:48:0)
[07:31:39.283] Timer tick, asking Buildbucket for the build status
[07:31:39.585] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:39.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:49:0) after 1m0s
[07:32:39.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:49:0)
[07:32:39.628] Timer tick, asking Buildbucket for the build status
[07:32:40.936] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:40.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:50:0) after 1m0s
[07:33:41.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:50:0)
[07:33:41.054] Timer tick, asking Buildbucket for the build status
[07:33:41.562] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:41.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:51:0) after 1m0s
[07:34:41.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:51:0)
[07:34:41.736] Timer tick, asking Buildbucket for the build status
[07:34:42.139] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:42.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:52:0) after 1m0s
[07:35:42.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:52:0)
[07:35:42.237] Timer tick, asking Buildbucket for the build status
[07:35:42.614] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:42.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:53:0) after 1m0s
[07:36:42.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:53:0)
[07:36:42.664] Timer tick, asking Buildbucket for the build status
[07:36:42.860] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:42.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:54:0) after 1m0s
[07:37:42.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:54:0)
[07:37:42.916] Timer tick, asking Buildbucket for the build status
[07:37:43.084] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:43.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:55:0) after 1m0s
[07:38:43.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:55:0)
[07:38:43.169] Timer tick, asking Buildbucket for the build status
[07:38:43.412] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:43.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:56:0) after 1m0s
[07:39:43.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:56:0)
[07:39:43.546] Timer tick, asking Buildbucket for the build status
[07:39:44.849] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:57:0) after 1m0s
[07:40:44.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:57:0)
[07:40:44.979] Timer tick, asking Buildbucket for the build status
[07:40:45.205] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:45.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:58:0) after 1m0s
[07:41:45.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:58:0)
[07:41:45.320] Timer tick, asking Buildbucket for the build status
[07:41:45.620] Build 8891308668363230320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:45.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056738730682108912:59:0) after 1m0s
[07:42:28.114] Received PubSub notification, asking Buildbucket for the build status
[07:42:28.278] Build 8891308668363230320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:42:28.279] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578987747097898",
"created_by": "project:chromium",
"created_ts": "1578984305949823",
"id": "8891308668363230320",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49961139306e66538e8fe2e850ef4aeeffcfc6f1\"}}",
"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-89-msn2\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167352, \"got_angle_revision\": \"c6ff255b602138b0f2f879e0fb5a764e4bb2c640\", \"got_dawn_revision\": \"e5cb8f2eff7e2b0f672c0d20fb97ca17fe28e94a\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"49961139306e66538e8fe2e850ef4aeeffcfc6f1\", \"got_revision_cp\": \"refs/heads/master@{#731109}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"488d35ac0b1c66c79a6a8511111ad5b6296a2ffb\", \"got_v8_revision\": \"3d04bd15b02d40f716b49dbb1cb97bb13c40741a\", \"got_v8_revision_cp\": \"refs/heads/8.1.170@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49961139306e66538e8fe2e850ef4aeeffcfc6f1\", \"swarm_hashes_refs/heads/master(at){#731109}_without_patch\": {\"accessibility_unittests\": \"a91dbbacd6a8a64b7fdadcc2f29ef82d0106675a\", \"angle_unittests\": \"3b01a99cf890780f451b782a27122d7ef5ad4efe\", \"app_shell_unittests\": \"c4c16c90e83536502df3b7395f2ccb5a58dde4cd\", \"aura_unittests\": \"2e51ab8c13632309bb8d011abd2ded1ba578fa6c\", \"base_unittests\": \"5395da6e7a552bc1cb01137676f64c986eb17aca\", \"base_util_unittests\": \"2a4bb8ea64f42a255047ac407569d670e8fd3535\", \"blink_common_unittests\": \"107d7a47503417ef76a08094ac590a14c2330fc1\", \"blink_fuzzer_unittests\": \"3ac4edb7386115aef1b5e682134cee9ce32d9841\", \"blink_heap_unittests\": \"fee9236b21f191a5f214df6fe85f2c13e02b7132\", \"blink_platform_unittests\": \"27e1147381a4b13cb74e970b158a4935f6c34b83\", \"blink_python_tests\": \"d8d3efcd999ac074861c1b85f1a860ccf716a619\", \"blink_unittests\": \"3ab01219f6838c0409e0f0cb14e121f653350fdd\", \"blink_web_tests\": \"356a8ecc39244e9e33da853510b4202a0f7593ca\", \"boringssl_crypto_tests\": \"ff3b5c6461ef9d3189e80404f6d7d347a313a436\", \"boringssl_ssl_tests\": \"be1114f11ab0113bc51ceb41c777bc24b65ea2f0\", \"browser_tests\": \"0b6bec46d318a007a21fc8b2809849c5d521ca80\", \"cacheinvalidation_unittests\": \"c6b6631e468acc770e6575dbe0646c87188f7fcb\", \"capture_unittests\": \"48ce5d4000e166456ed390dbf74d3f542b0caa0f\", \"cast_unittests\": \"3496333b79edb0ad4d60ebe0baaf7bd5ce6d4e4f\", \"cc_unittests\": \"636d0dc19c36f0ea873d301d36cdabd0889e9b5d\", \"chrome_app_unittests\": \"ccc3c6c10dc5aca6f6f52f51a0984d1990262418\", \"chromedriver_unittests\": \"c2e36f7ec30ea56ea517bfd8265649d930c3e479\", \"components_browsertests\": \"5959b33289330a11e92b5fbe0614cb30a6e8e96b\", \"components_unittests\": \"7c31f8a02323eabe199b61337e789c6916de944b\", \"compositor_unittests\": \"b1da324401aec2255379cff54b8f3dce76112713\", \"content_browsertests\": \"b8d5f854f6ea96b56f1868e4a009d71531a77dbd\", \"content_shell_crash_test\": \"07d85ecd7170cae04e02455c7431a410de332a38\", \"content_unittests\": \"ab99fe8d864b990fb7a4efebc51b0c42f99ee5f0\", \"crashpad_tests\": \"76f2a7464c8b4c6b3b3e560b25333fed3584a6af\", \"cronet_tests\": \"760668bacc0baaf42d27550dd062924945ff59fc\", \"cronet_unittests\": \"6d0807ae06fce9f2485e9a8784602b6009d92680\", \"crypto_unittests\": \"614d7a6840d2079d1b9adcddaa6c53ef80c04c47\", \"dbus_unittests\": \"492fc889bd2d1a72f4fd57ec3552a62526b7fd3a\", \"device_unittests\": \"5c04f4056d9a85f7e36824287c4ea252e274527d\", \"devtools_lint_check\": \"94bfb9913dfd14c0318faf87227ec9a6381aaa99\", \"devtools_type_check\": \"97e5a26c764c28fb934447a3dc8572caeb6926d1\", \"display_unittests\": \"40ba1d7c53d6ccc3d6668ef3f89952578f8054ef\", \"events_unittests\": \"e7cca3448200bdcc4ae2e44faea868cc823b86df\", \"extensions_browsertests\": \"ef5f82e51544d3e4242493d29afe75699ad438b0\", \"extensions_unittests\": \"1718dadabe1151619b1ffa638deb559493454ce6\", \"filesystem_service_unittests\": \"877b805d1c34e6213960e86f8d0a03e584fb2023\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"c1ba8976fef8ba8bc47b8c4ec45cbabee2bef596\", \"gfx_unittests\": \"83fb5074075ad93695a1410c6392770492510e60\", \"gin_unittests\": \"0748fa7aa394f1247eeaad101c3c3d0239765921\", \"google_apis_unittests\": \"502c554a0caf8d0cdd335490f9f747cf53e2c255\", \"gpu_unittests\": \"86e9ef38ba213eca5fa29460eb289974d78d5bf3\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"9e08b93671011afbea741955e96e204f0de4c75e\", \"headless_browsertests\": \"c019ed8f930ad18fafaba275493b6fa02035a739\", \"headless_unittests\": \"e563e7c0a6dfe6d05e6131ca3e6bf874f699ad01\", \"interactive_ui_tests\": \"c8574c261ac5bc9d496ed3f1cd8ba158d4194ec2\", \"ipc_tests\": \"f5a18ab9e7b1900c1584b1a4983bd3d6e198555e\", \"jingle_unittests\": \"ff0a11d0dccfb3289fdb2b79999becaba38a651e\", \"latency_unittests\": \"a729c89b1b0421b0f5c8fd5b3dfa96266a521b55\", \"libjingle_xmpp_unittests\": \"840dc88e5a877321b602482fba94995cd9fcac93\", \"media_blink_unittests\": \"526a1d8dafbef90413895c8aa2efa63a510efc54\", \"media_service_unittests\": \"81634e71984cbaa0b4b8ae6b2fb65196ff8ff970\", \"media_unittests\": \"116fc1198ea7a9e953ddc7371c9eaf11552f961d\", \"message_center_unittests\": \"c5be2fa3b6c46c2e4ec698bfc9fb50253c0d5b1d\", \"metrics_python_tests\": \"6929f6a4bba20c3846eccd8573837cdecc9eb0f9\", \"midi_unittests\": \"469d4a7295333e06faea4a99ad62e5bc1bd6bc7b\", \"mojo_core_unittests\": \"ff43172ff3b1abd63f3893b5787c21103de31b42\", \"mojo_unittests\": \"e51a26232e93cf453bd8e6b13387af2ae690de88\", \"nacl_helper_nonsfi_unittests\": \"4c6a5e632118cea91f4fb40b751bbb44bddd16f6\", \"nacl_loader_unittests\": \"5083943da923873c7c936610e975534ceba0dd81\", \"native_theme_unittests\": \"acebf4fdbd9f9d1d1494118771cee3883ef71e83\", \"net_unittests\": \"2c50f0a79d901a5ee485103ba88feab69c10a386\", \"pdf_unittests\": \"41a8225b2866ce300a77c286cf97df12fe5f7c8d\", \"perfetto_unittests\": \"edb8b3aefc9c110a343ba6dc2e7ac858d141dac1\", \"ppapi_unittests\": \"9e4471ce6c51acbd564fd3b87d66cc80c36a41d5\", \"printing_unittests\": \"2b940efbf04e19ef53dd85a0c11952f7e04b81a7\", \"remoting_unittests\": \"b34e5322cb792e04b3ab317c01103fb390ed9daa\", \"sandbox_linux_unittests\": \"e8096309dda2de61d95651f37b1ac97887faa9ea\", \"service_manager_unittests\": \"757966144820f3a52eabf023495aa19b48d59fc3\", \"services_unittests\": \"b6081e2c13cb067d4f5b6fce8c7ae29ef4b5c0f1\", \"shell_dialogs_unittests\": \"edf5f51fdf4cd5abb15242702be5f1ea55bd50af\", \"skia_unittests\": \"8446ab99cca1be82a9a5f622d44e3e1ea45693ec\", \"snapshot_unittests\": \"74346b20dcc77fc6ea82a7537c83c1e2353ad9b5\", \"sql_unittests\": \"fe759ef4aa20c33a7c7cd161604c23c2d7cf7a1a\", \"storage_unittests\": \"71a775abbab2f83dfbbe8003e79e56d1b0dc34d3\", \"sync_integration_tests\": \"b8cd5a6f64c0e99660faab3a990a8c6c3d824266\", \"telemetry_gpu_unittests\": \"be78f903353385ce89627542ac0d1c550dfd3e4c\", \"telemetry_perf_unittests\": \"ae416f451115eeb216e2acda451cfdef253fd204\", \"telemetry_unittests\": \"ed4cc6b8dbd744a36e3926e7b4bf079d833c53a6\", \"traffic_annotation_auditor_unittests\": \"c5d244617f67cdd98e4a54c90df161f1ec6064c1\", \"ui_base_unittests\": \"cbe8f41cf9a73137564743fbc26ab38a0b487813\", \"ui_touch_selection_unittests\": \"52f9a9a073d1d5e0abd7467a627f0b76df36c064\", \"unit_tests\": \"cf3f8c1308e6d2d4a4cd21f13b0b1b88d25ec8d3\", \"url_unittests\": \"ec19a2251cffb09841c3b0a1ed2d4b6ece7170aa\", \"views_perftests\": \"9906683573a817b843236c66f91a07aa0845deef\", \"views_unittests\": \"14fba11822a40b83f668e4ab0d8531202f1b22ea\", \"viz_unittests\": \"93ef291a9230697043fc5fe4db2f75731d32ac79\", \"vr_common_unittests\": \"32e1386e49dda854c54431314636b5bd4d22e568\", \"vr_pixeltests\": \"033b635492b2a559193e9970832cd0c7139825fc\", \"webdriver_wpt_tests\": \"e0d71cc8425cbaae6914d82fc051d5e325afbcb5\", \"weblayer_browsertests\": \"5555011dea76f39e4436a156718d61f24a69ade3\", \"wm_unittests\": \"fcd05e4d4ee5777d0e5c8f4dab7af7abd2d25fe5\", \"wtf_unittests\": \"a0040c89c1fd3db60c86cc03f14697ebfc3dc817\", \"xr_browser_tests\": \"5b81433c3d8eadf7e52fdb15758ab65b2c87efd4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3b404fa22a3c1a181985100df1a34c166b035b5f7265e772f51e56790f9dc011_v2\", \"builder_9ccb21220795a1d1972030c6b5d9b4569472a28790e1458f6676edb8e4495e8f_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-89-msn2\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578984614754135",
"status": "COMPLETED",
"status_changed_ts": "1578987747366892",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167352",
"builder:Linux Builder (dbg)",
"buildset:commit/git/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49961139306e66538e8fe2e850ef4aeeffcfc6f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056738730682108912",
"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/8891308668363230320/+/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:49bb9e6268266a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1578987747371318",
"url": "https://ci.chromium.org/b/8891308668363230320",
"utcnow_ts": "1578987748262015"
}
}
[07:42:28.279] Invocation finished in 57m23.924791133s with status SUCCEEDED