[18:46:00.142] New invocation is queued and will start shortly
[18:46:01.264] Starting the invocation (attempt 1)
[18:46:01.299] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:46:01.299] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:46:01.299] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054156658662388816",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eba00a2ffc6538b7ab88670e9a49419737d39715\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054156658662388816",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/eba00a2ffc6538b7ab88670e9a49419737d39715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eba00a2ffc6538b7ab88670e9a49419737d39715",
"gitiles_ref:refs/heads/master"
]
}
[18:46:03.038] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581446762141206",
"id": "8888726595899238624",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eba00a2ffc6538b7ab88670e9a49419737d39715\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581446762767135",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168491",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eba00a2ffc6538b7ab88670e9a49419737d39715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eba00a2ffc6538b7ab88670e9a49419737d39715",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054156658662388816",
"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/8888726595899238624/+/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": "1581446762799477",
"url": "https://ci.chromium.org/b/8888726595899238624",
"utcnow_ts": "1581446763023279"
}
}
[18:46:03.038] Task URL: https://ci.chromium.org/b/8888726595899238624
[18:46:03.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:2:0) after 1m0s
[18:47:03.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:2:0)
[18:47:03.097] Timer tick, asking Buildbucket for the build status
[18:47:03.299] Build 8888726595899238624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:03.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:3:0) after 1m0s
[18:47:19.839] Received PubSub notification, asking Buildbucket for the build status
[18:47:19.930] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:3:0)
[18:48:03.374] Timer tick, asking Buildbucket for the build status
[18:48:03.916] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:5:0) after 1m0s
[18:49:03.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:5:0)
[18:49:03.931] Timer tick, asking Buildbucket for the build status
[18:49:04.056] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:04.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:6:0) after 1m0s
[18:50:04.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:6:0)
[18:50:04.115] Timer tick, asking Buildbucket for the build status
[18:50:04.337] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:7:0) after 1m0s
[18:51:04.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:7:0)
[18:51:04.427] Timer tick, asking Buildbucket for the build status
[18:51:04.537] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:04.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:8:0) after 1m0s
[18:52:04.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:8:0)
[18:52:04.610] Timer tick, asking Buildbucket for the build status
[18:52:04.753] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:04.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:9:0) after 1m0s
[18:53:04.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:9:0)
[18:53:04.817] Timer tick, asking Buildbucket for the build status
[18:53:05.642] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:10:0) after 1m0s
[18:54:05.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:10:0)
[18:54:05.797] Timer tick, asking Buildbucket for the build status
[18:54:06.087] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:06.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:11:0) after 1m0s
[18:55:06.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:11:0)
[18:55:06.176] Timer tick, asking Buildbucket for the build status
[18:55:06.744] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:06.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:12:0) after 1m0s
[18:56:06.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:12:0)
[18:56:06.777] Timer tick, asking Buildbucket for the build status
[18:56:07.472] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:07.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:13:0) after 1m0s
[18:57:07.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:13:0)
[18:57:07.582] Timer tick, asking Buildbucket for the build status
[18:57:07.867] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:07.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:14:0) after 1m0s
[18:58:08.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:14:0)
[18:58:08.027] Timer tick, asking Buildbucket for the build status
[18:58:08.479] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:08.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:15:0) after 1m0s
[18:59:08.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:15:0)
[18:59:08.540] Timer tick, asking Buildbucket for the build status
[18:59:08.745] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:08.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:16:0) after 1m0s
[19:00:08.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:16:0)
[19:00:08.833] Timer tick, asking Buildbucket for the build status
[19:00:09.003] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:17:0) after 1m0s
[19:01:09.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:17:0)
[19:01:09.367] Timer tick, asking Buildbucket for the build status
[19:01:09.598] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:09.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:18:0) after 1m0s
[19:02:09.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:18:0)
[19:02:09.832] Timer tick, asking Buildbucket for the build status
[19:02:09.971] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:09.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:19:0) after 1m0s
[19:03:10.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:19:0)
[19:03:10.135] Timer tick, asking Buildbucket for the build status
[19:03:10.656] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:10.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:20:0) after 1m0s
[19:04:10.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:20:0)
[19:04:10.923] Timer tick, asking Buildbucket for the build status
[19:04:11.148] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:11.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:21:0) after 1m0s
[19:05:11.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:21:0)
[19:05:11.210] Timer tick, asking Buildbucket for the build status
[19:05:11.351] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:11.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:22:0) after 1m0s
[19:06:11.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:22:0)
[19:06:11.442] Timer tick, asking Buildbucket for the build status
[19:06:11.615] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:11.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:23:0) after 1m0s
[19:07:11.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:23:0)
[19:07:11.655] Timer tick, asking Buildbucket for the build status
[19:07:11.857] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:11.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:24:0) after 1m0s
[19:08:11.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:24:0)
[19:08:11.971] Timer tick, asking Buildbucket for the build status
[19:08:12.713] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:12.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:25:0) after 1m0s
[19:09:13.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:25:0)
[19:09:13.112] Timer tick, asking Buildbucket for the build status
[19:09:14.312] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:14.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:26:0) after 1m0s
[19:10:14.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:26:0)
[19:10:14.347] Timer tick, asking Buildbucket for the build status
[19:10:14.780] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:14.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:27:0) after 1m0s
[19:11:14.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:27:0)
[19:11:14.997] Timer tick, asking Buildbucket for the build status
[19:11:15.692] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:28:0) after 1m0s
[19:12:16.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:28:0)
[19:12:16.041] Timer tick, asking Buildbucket for the build status
[19:12:16.562] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:16.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:29:0) after 1m0s
[19:13:16.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:29:0)
[19:13:16.751] Timer tick, asking Buildbucket for the build status
[19:13:16.923] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:30:0) after 1m0s
[19:14:17.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:30:0)
[19:14:17.201] Timer tick, asking Buildbucket for the build status
[19:14:17.406] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:17.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:31:0) after 1m0s
[19:15:17.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:31:0)
[19:15:17.624] Timer tick, asking Buildbucket for the build status
[19:15:17.914] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:17.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:32:0) after 1m0s
[19:16:18.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:32:0)
[19:16:18.481] Timer tick, asking Buildbucket for the build status
[19:16:18.659] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:18.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:33:0) after 1m0s
[19:17:18.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:33:0)
[19:17:18.978] Timer tick, asking Buildbucket for the build status
[19:17:19.200] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:34:0) after 1m0s
[19:18:19.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:34:0)
[19:18:19.485] Timer tick, asking Buildbucket for the build status
[19:18:19.630] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:19.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:35:0) after 1m0s
[19:19:19.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:35:0)
[19:19:19.912] Timer tick, asking Buildbucket for the build status
[19:19:20.051] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:20.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:36:0) after 1m0s
[19:20:20.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:36:0)
[19:20:20.320] Timer tick, asking Buildbucket for the build status
[19:20:20.670] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:20.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:37:0) after 1m0s
[19:21:20.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:37:0)
[19:21:20.759] Timer tick, asking Buildbucket for the build status
[19:21:21.039] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:21.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:38:0) after 1m0s
[19:22:21.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:38:0)
[19:22:21.371] Timer tick, asking Buildbucket for the build status
[19:22:21.862] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:21.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:39:0) after 1m0s
[19:23:22.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:39:0)
[19:23:22.163] Timer tick, asking Buildbucket for the build status
[19:23:22.360] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:22.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:40:0) after 1m0s
[19:24:22.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:40:0)
[19:24:22.415] Timer tick, asking Buildbucket for the build status
[19:24:22.547] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:41:0) after 1m0s
[19:25:22.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:41:0)
[19:25:22.760] Timer tick, asking Buildbucket for the build status
[19:25:22.986] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:22.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:42:0) after 1m0s
[19:26:23.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:42:0)
[19:26:23.181] Timer tick, asking Buildbucket for the build status
[19:26:23.785] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:23.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:43:0) after 1m0s
[19:27:23.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:43:0)
[19:27:23.928] Timer tick, asking Buildbucket for the build status
[19:27:24.146] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:24.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:44:0) after 1m0s
[19:28:24.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:44:0)
[19:28:24.181] Timer tick, asking Buildbucket for the build status
[19:28:24.896] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:24.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:45:0) after 1m0s
[19:29:25.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:45:0)
[19:29:25.048] Timer tick, asking Buildbucket for the build status
[19:29:25.216] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:25.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:46:0) after 1m0s
[19:30:25.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:46:0)
[19:30:25.247] Timer tick, asking Buildbucket for the build status
[19:30:25.872] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:25.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:47:0) after 1m0s
[19:31:25.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:47:0)
[19:31:25.961] Timer tick, asking Buildbucket for the build status
[19:31:26.178] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:26.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:48:0) after 1m0s
[19:32:26.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:48:0)
[19:32:26.312] Timer tick, asking Buildbucket for the build status
[19:32:28.922] Build 8888726595899238624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:28.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054156658662388816:49:0) after 1m0s
[19:32:47.845] Received PubSub notification, asking Buildbucket for the build status
[19:32:48.012] Build 8888726595899238624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:32:48.012] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581449567347284",
"created_by": "project:chromium",
"created_ts": "1581446762141206",
"id": "8888726595899238624",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eba00a2ffc6538b7ab88670e9a49419737d39715\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-63-r2hp\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168491, \"got_angle_revision\": \"b40d48a67c932625f349c6e58036c2d96b62489b\", \"got_dawn_revision\": \"713d9cbf939e525e025a69a17bda0bf51b449c47\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"eba00a2ffc6538b7ab88670e9a49419737d39715\", \"got_revision_cp\": \"refs/heads/master@{#740368}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"196d81774ef86d1c6c2d028dd5407b47eaa51a99\", \"got_v8_revision\": \"d0da7b4db4d335d91a374ec3be53199c482e7174\", \"got_v8_revision_cp\": \"refs/heads/8.2.56@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eba00a2ffc6538b7ab88670e9a49419737d39715\", \"swarm_hashes_refs/heads/master(at){#740368}_without_patch\": {\"accessibility_unittests\": \"e27f29b1b145d05fbbaeb16e9898b9e633a4ebe9\", \"angle_unittests\": \"4b5fb0bec81ba61c01723ff66c98adae9e61f53d\", \"app_shell_unittests\": \"a0621152d17e9a389d3dc2c54fb2933b1788aa3e\", \"aura_unittests\": \"7fba023ba16db6ef7e983b2d5dc4daf2b12298fd\", \"base_unittests\": \"eab03b1ca04ffdefc5f57906c697482b32acbaba\", \"base_util_unittests\": \"74042a8d363256e8e45437af6b2b7cf667f3044c\", \"blink_common_unittests\": \"666fb612667921b4f49f6f3b1a3b4ded653582ec\", \"blink_fuzzer_unittests\": \"b7664eae72fae48a92e268b1a5a3e94c605a2704\", \"blink_heap_unittests\": \"2ee9d76cca43302ed3aa4340968e95c91d6eb59b\", \"blink_platform_unittests\": \"a687fab6fd739922582c6f0560d20014290f91c9\", \"blink_python_tests\": \"89cb07c4779d6823b14ee4ca1a10c16255ed7d7f\", \"blink_unittests\": \"8da0932043cb9dae762387477ec01216c57a0e8d\", \"blink_web_tests\": \"3691cffa2691810d3fa2e46f0f696ed8bd45ec2d\", \"boringssl_crypto_tests\": \"60cfd6f6d968c11bf815a112934f52c9ba8acced\", \"boringssl_ssl_tests\": \"523f6d6b5a38170f8ae28820c3b6f7138adb87ba\", \"browser_tests\": \"1e0db4d0667505b98e61e144a0b989c18b814411\", \"cacheinvalidation_unittests\": \"311698b85a7ef57e58bd5beb9cd18783e06bcafe\", \"capture_unittests\": \"14acdd3596b3174548f0f1c51f958959f5bdca5d\", \"cast_unittests\": \"4a0aacbd2e70d71364a3a71f6e4dadf71f1dc10f\", \"cc_unittests\": \"fc8f21f2916e7142aa9f6b34b0e5b6c17031d493\", \"chrome_app_unittests\": \"16d8f873f01662887fd02b679116902a9ce8088a\", \"chromedriver_unittests\": \"14c428b8dd5ff52df9f9043879b72d09860b9339\", \"components_browsertests\": \"f8b51a97ba5bb48ba7ee70c42897d7e710801dd8\", \"components_unittests\": \"566d010044cd1371a8a43a592efa6231dbaf8fd3\", \"compositor_unittests\": \"e5ccbc198f3edc338ddc57dbb9347778b39eb960\", \"content_browsertests\": \"6a2f2df4d94778faeb680f9743bf5bc2c6d021f6\", \"content_shell_crash_test\": \"6cba8a9f75776cdacef0672b1ca55a97189e2357\", \"content_unittests\": \"347c540b970fa2e4a6c1794da7bdff03610bd90b\", \"crashpad_tests\": \"e54076a009d63d4191413a4e782050416c2ac726\", \"cronet_tests\": \"2f29e0eea264c5d40dbbfea417fa87db32386646\", \"cronet_unittests\": \"dcfc38552d0f9a620b802316f80edb7f73e59eae\", \"crypto_unittests\": \"bb6a24422c3c82d3892c2877204e1c1cf8c44227\", \"dbus_unittests\": \"a56018a2fd525afe17e30bec818920e6039b914e\", \"device_unittests\": \"70b01f6526d33a57be107f37d2dd666e6ee3e780\", \"display_unittests\": \"069d70a075febae53b4e2dc79a5b3ccc3b2eca36\", \"events_unittests\": \"dc32da6425bb2a12298a2bf19749d3eac5201401\", \"extensions_browsertests\": \"2f5a41179759f6a88ef93457b85930f6e1f4381c\", \"extensions_unittests\": \"c12eefbc5abf4f29788b4abf17a6c46ed664952b\", \"filesystem_service_unittests\": \"6128808a6dbf5abb2128a44f76d74f513dc17cc5\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"1409f74d06f18f11ac18f066186863397f9b6f10\", \"gfx_unittests\": \"6d8c12e4d427d18611e23b3d432f5ef2a2dc5cd5\", \"gin_unittests\": \"18032518f238a4c7ed07e7b1a0a5f22278c135ac\", \"google_apis_unittests\": \"32b15089c949667ccabe92a10f9a106c8232d91b\", \"gpu_unittests\": \"3fbb6d3a483931fdc9e5bf40c302cadb5a30efd0\", \"grit_python_unittests\": \"2c197a1bd065e31b00ed1c7636679f90a901aabe\", \"gwp_asan_unittests\": \"0a44c745c4606a3e2565f247bbc6eb332d6034a5\", \"headless_browsertests\": \"ce8339134c27ee6d9a38a34818696fc416b5f21d\", \"headless_unittests\": \"f3b2f59567173bf612485b48f0760b351525d102\", \"interactive_ui_tests\": \"a3f8d63ef4704e586786c0f6adec045a6a382d32\", \"ipc_tests\": \"3972c1412ee83076ab02ca4b050a42146eed7ab7\", \"jingle_unittests\": \"d23dffeac38cfa9b85778cf1a8d129d2c20df7e6\", \"latency_unittests\": \"15399b5569fcc5480ff3fd6a9d9ab51627006ad9\", \"libjingle_xmpp_unittests\": \"74da39a0909406f8e6150354c490b24389d963a4\", \"media_blink_unittests\": \"7404f4e7acee7d2c44dd583a12cced9f35308590\", \"media_service_unittests\": \"05dd2ca1aec56b002da4551f59ddd486d3f98442\", \"media_unittests\": \"0b1f11bce92bc6808828b9f41e9faa81fe3ec821\", \"message_center_unittests\": \"e5ba686aeb80ca08dd7064b5df328ada63cec2dc\", \"metrics_python_tests\": \"db597ad3b7275591ba89cbd8162c6487f2458dde\", \"midi_unittests\": \"6bf1dc599164c619c52c48cb48b5fbe09b400c4e\", \"mojo_core_unittests\": \"8d41e070d6e38fd76ffd1deae3d5307b51a5a6a3\", \"mojo_unittests\": \"8c16cfe55ce1fd2bc5d049ba3d5fd72b3735d903\", \"nacl_helper_nonsfi_unittests\": \"435a37c530c2fed9373c89fc3d2c90b6efce927b\", \"nacl_loader_unittests\": \"3e9d4b958c3f71c5740a176e76ba7444318efbdb\", \"native_theme_unittests\": \"cebee001ba454c1bf2f4e63ba23dddce63eb9c24\", \"net_unittests\": \"43cc83f80936144273336be7ebfbfb1009ec21c9\", \"pdf_unittests\": \"b10fb9de6401e3235c07e80399f1a02eba017188\", \"perfetto_unittests\": \"6eaa08f45edabb7a5c9b1673e0eee6cdba9aa7fc\", \"ppapi_unittests\": \"e5a8cda4ae47e00bde24e7b144b887dbd2c9ccec\", \"printing_unittests\": \"fb432e6170874162ca72efd534afc9c7d2351044\", \"remoting_unittests\": \"1ac099963f8c1dc2a0d3f1081e390b06cb44bbd3\", \"sandbox_linux_unittests\": \"3d117347cefae28a408b5c2645847fd4c5641aa7\", \"service_manager_unittests\": \"4c5f450bfe818de5c4ecf0779e06096e1363a8b3\", \"services_unittests\": \"3a76ad02c4c5aacaa7cc27d803280592f90ec4ae\", \"shell_dialogs_unittests\": \"51f2db09af9915465cb90d9834e9f42de1c5fb98\", \"skia_unittests\": \"10bd705729851228c082846d87a30ea4c6754767\", \"snapshot_unittests\": \"70cb7d43a3fea583e53aef12d811e886ee781c92\", \"sql_unittests\": \"30998c2d90f45e29abb7c0b04578062934851a99\", \"storage_unittests\": \"fcc816449ecf9aca3a4f451b63ff073f498811e9\", \"sync_integration_tests\": \"334a285c6da093c171933935c4d9725a95cd2899\", \"telemetry_gpu_unittests\": \"fe1d39afab94c80a9813eaa1fb0e44c601a400b7\", \"telemetry_perf_unittests\": \"d4294e9440a4ac0c20e98de6af36fff3c123a57f\", \"telemetry_unittests\": \"780a1a3635a9183a8ab385386499c1932c63a778\", \"traffic_annotation_auditor_unittests\": \"23173584ecc17ca402ddfc06995b1beed352e769\", \"ui_base_unittests\": \"6d36a77cf3bb4889cdae84be54638974bae124d8\", \"ui_touch_selection_unittests\": \"7a5e4cef2a3fc0e59a4a279b1d0b455758bac773\", \"unit_tests\": \"ebba8ae7c6a54d51d699370212f38944d24d971d\", \"url_unittests\": \"914caa414937cdeb32952b5296b686f6ee0e9f90\", \"views_perftests\": \"9c7989d8e053ed38e39384f5e460aea9fc2a8d14\", \"views_unittests\": \"6510a548b8a8cec3bced1b7ab125c6b1c21b565a\", \"viz_unittests\": \"5158236960fc8734b9d01e9755bdb44938cae7cf\", \"vr_common_unittests\": \"390eed9a80fe8f9198eb277b4be54b30b05ed160\", \"vr_pixeltests\": \"8d3e9238bc4cc95a474262b1cb91cfcbcdef7a04\", \"webdriver_wpt_tests\": \"26f2dbb341f90a67e2988f424fc2c382a9f21378\", \"weblayer_browsertests\": \"2d81df973a94195660b114cd837de7fe1e065c2d\", \"wm_unittests\": \"36df9c93e57e325c0b69b47c483c870701ea05cd\", \"wtf_unittests\": \"e36ada7e9a2e6c7b1dd89ff26e193f6c6a202bfb\", \"xr_browser_tests\": \"0c1f473587c1d0aefa3fa00a8f7f56646943ff87\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_836dfd76661dd6ce0283c27a20a4f1b22697b2b6477701844f76cebb302cb05b_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-63-r2hp\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581446838611128",
"status": "COMPLETED",
"status_changed_ts": "1581449567577349",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168491",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eba00a2ffc6538b7ab88670e9a49419737d39715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eba00a2ffc6538b7ab88670e9a49419737d39715",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054156658662388816",
"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/8888726595899238624/+/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:4a4e641a5a183310",
"user_agent:luci-scheduler"
],
"updated_ts": "1581449567580579",
"url": "https://ci.chromium.org/b/8888726595899238624",
"utcnow_ts": "1581449568003746"
}
}
[19:32:48.012] Invocation finished in 46m47.889291339s with status SUCCEEDED