[03:41:38.562] New invocation is queued and will start shortly
[03:41:39.750] Starting the invocation (attempt 1)
[03:41:39.787] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:41:39.788] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:41:39.788] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052854601559466272",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49ccb72a7dc27faa1c4724c34c220c23762cefe6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052854601559466272",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"gitiles_ref:refs/heads/master"
]
}
[03:41:41.370] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582688499978017",
"id": "8887424539404924992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49ccb72a7dc27faa1c4724c34c220c23762cefe6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582688501074164",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169028",
"builder:Linux Builder (dbg)",
"buildset:commit/git/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052854601559466272",
"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/8887424539404924992/+/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": "1582688501074361",
"url": "https://ci.chromium.org/b/8887424539404924992",
"utcnow_ts": "1582688501359101"
}
}
[03:41:41.370] Task URL: https://ci.chromium.org/b/8887424539404924992
[03:41:41.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:2:0) after 1m0s
[03:42:41.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:2:0)
[03:42:41.447] Timer tick, asking Buildbucket for the build status
[03:42:41.619] Build 8887424539404924992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:41.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:3:0) after 1m0s
[03:43:41.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:3:0)
[03:43:41.675] Timer tick, asking Buildbucket for the build status
[03:43:41.830] Build 8887424539404924992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:41.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:4:0) after 1m0s
[03:44:41.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:4:0)
[03:44:41.870] Timer tick, asking Buildbucket for the build status
[03:44:42.059] Build 8887424539404924992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:42.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:5:0) after 1m0s
[03:45:42.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:5:0)
[03:45:42.162] Timer tick, asking Buildbucket for the build status
[03:45:42.258] Build 8887424539404924992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:42.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:6:0) after 1m0s
[03:46:07.531] Received PubSub notification, asking Buildbucket for the build status
[03:46:07.620] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:42.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:6:0)
[03:46:42.302] Timer tick, asking Buildbucket for the build status
[03:46:42.552] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:42.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:8:0) after 1m0s
[03:47:42.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:8:0)
[03:47:42.638] Timer tick, asking Buildbucket for the build status
[03:47:42.984] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:42.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:9:0) after 1m0s
[03:48:43.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:9:0)
[03:48:43.062] Timer tick, asking Buildbucket for the build status
[03:48:43.278] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:43.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:10:0) after 1m0s
[03:49:43.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:10:0)
[03:49:43.294] Timer tick, asking Buildbucket for the build status
[03:49:43.414] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:11:0) after 1m0s
[03:50:43.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:11:0)
[03:50:43.552] Timer tick, asking Buildbucket for the build status
[03:50:43.651] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:12:0) after 1m0s
[03:51:43.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:12:0)
[03:51:43.743] Timer tick, asking Buildbucket for the build status
[03:51:43.961] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:43.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:13:0) after 1m0s
[03:52:44.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:13:0)
[03:52:44.139] Timer tick, asking Buildbucket for the build status
[03:52:44.303] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:14:0) after 1m0s
[03:53:44.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:14:0)
[03:53:44.596] Timer tick, asking Buildbucket for the build status
[03:53:44.785] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:44.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:15:0) after 1m0s
[03:54:44.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:15:0)
[03:54:44.846] Timer tick, asking Buildbucket for the build status
[03:54:44.958] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:44.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:16:0) after 1m0s
[03:55:45.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:16:0)
[03:55:45.009] Timer tick, asking Buildbucket for the build status
[03:55:45.074] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:45.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:17:0) after 1m0s
[03:56:45.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:17:0)
[03:56:45.159] Timer tick, asking Buildbucket for the build status
[03:56:45.319] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:45.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:18:0) after 1m0s
[03:57:45.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:18:0)
[03:57:45.338] Timer tick, asking Buildbucket for the build status
[03:57:45.428] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:45.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:19:0) after 1m0s
[03:58:45.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:19:0)
[03:58:45.407] Timer tick, asking Buildbucket for the build status
[03:58:45.516] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:45.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:20:0) after 1m0s
[03:59:45.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:20:0)
[03:59:45.655] Timer tick, asking Buildbucket for the build status
[03:59:45.858] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:45.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:21:0) after 1m0s
[04:00:45.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:21:0)
[04:00:45.963] Timer tick, asking Buildbucket for the build status
[04:00:46.262] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:46.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:22:0) after 1m0s
[04:01:46.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:22:0)
[04:01:46.383] Timer tick, asking Buildbucket for the build status
[04:01:46.450] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:46.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:23:0) after 1m0s
[04:02:46.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:23:0)
[04:02:46.453] Timer tick, asking Buildbucket for the build status
[04:02:47.424] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:47.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:24:0) after 1m0s
[04:03:47.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:24:0)
[04:03:47.452] Timer tick, asking Buildbucket for the build status
[04:03:47.742] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:47.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:25:0) after 1m0s
[04:04:47.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:25:0)
[04:04:47.811] Timer tick, asking Buildbucket for the build status
[04:04:48.296] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:48.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:26:0) after 1m0s
[04:05:48.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:26:0)
[04:05:48.387] Timer tick, asking Buildbucket for the build status
[04:05:48.740] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:27:0) after 1m0s
[04:06:48.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:27:0)
[04:06:48.726] Timer tick, asking Buildbucket for the build status
[04:06:48.801] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:48.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:28:0) after 1m0s
[04:07:49.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:28:0)
[04:07:49.078] Timer tick, asking Buildbucket for the build status
[04:07:49.460] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:49.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:29:0) after 1m0s
[04:08:49.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:29:0)
[04:08:49.592] Timer tick, asking Buildbucket for the build status
[04:08:49.889] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:49.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:30:0) after 1m0s
[04:09:49.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:30:0)
[04:09:49.937] Timer tick, asking Buildbucket for the build status
[04:09:50.197] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:50.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:31:0) after 1m0s
[04:10:50.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:31:0)
[04:10:50.379] Timer tick, asking Buildbucket for the build status
[04:10:50.474] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:50.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:32:0) after 1m0s
[04:11:50.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:32:0)
[04:11:50.515] Timer tick, asking Buildbucket for the build status
[04:11:50.636] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:50.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:33:0) after 1m0s
[04:12:50.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:33:0)
[04:12:50.729] Timer tick, asking Buildbucket for the build status
[04:12:50.850] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:50.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:34:0) after 1m0s
[04:13:51.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:34:0)
[04:13:51.012] Timer tick, asking Buildbucket for the build status
[04:13:51.158] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:51.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:35:0) after 1m0s
[04:14:51.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:35:0)
[04:14:51.244] Timer tick, asking Buildbucket for the build status
[04:14:51.505] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:51.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:36:0) after 1m0s
[04:15:51.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:36:0)
[04:15:51.597] Timer tick, asking Buildbucket for the build status
[04:15:51.846] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:51.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:37:0) after 1m0s
[04:16:51.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:37:0)
[04:16:51.959] Timer tick, asking Buildbucket for the build status
[04:16:53.085] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:53.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:38:0) after 1m0s
[04:17:53.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:38:0)
[04:17:53.155] Timer tick, asking Buildbucket for the build status
[04:17:53.255] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:53.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:39:0) after 1m0s
[04:18:53.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:39:0)
[04:18:53.287] Timer tick, asking Buildbucket for the build status
[04:18:53.509] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:53.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:40:0) after 1m0s
[04:19:53.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:40:0)
[04:19:53.663] Timer tick, asking Buildbucket for the build status
[04:19:53.783] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:53.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:41:0) after 1m0s
[04:20:53.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:41:0)
[04:20:53.837] Timer tick, asking Buildbucket for the build status
[04:20:53.948] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:53.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:42:0) after 1m0s
[04:21:54.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:42:0)
[04:21:54.057] Timer tick, asking Buildbucket for the build status
[04:21:54.256] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:54.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:43:0) after 1m0s
[04:22:54.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:43:0)
[04:22:54.454] Timer tick, asking Buildbucket for the build status
[04:22:54.554] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:54.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:44:0) after 1m0s
[04:23:54.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:44:0)
[04:23:54.679] Timer tick, asking Buildbucket for the build status
[04:23:54.805] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:54.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:45:0) after 1m0s
[04:24:54.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:45:0)
[04:24:54.822] Timer tick, asking Buildbucket for the build status
[04:24:54.951] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:54.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:46:0) after 1m0s
[04:25:55.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:46:0)
[04:25:55.044] Timer tick, asking Buildbucket for the build status
[04:25:55.135] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:55.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:47:0) after 1m0s
[04:26:55.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:47:0)
[04:26:55.272] Timer tick, asking Buildbucket for the build status
[04:26:55.611] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:55.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:48:0) after 1m0s
[04:27:55.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:48:0)
[04:27:55.797] Timer tick, asking Buildbucket for the build status
[04:27:55.993] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:55.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:49:0) after 1m0s
[04:28:56.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:49:0)
[04:28:56.079] Timer tick, asking Buildbucket for the build status
[04:28:56.232] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:50:0) after 1m0s
[04:29:56.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:50:0)
[04:29:56.259] Timer tick, asking Buildbucket for the build status
[04:29:56.430] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:56.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:51:0) after 1m0s
[04:30:56.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:51:0)
[04:30:56.549] Timer tick, asking Buildbucket for the build status
[04:30:56.763] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:52:0) after 1m0s
[04:31:56.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:52:0)
[04:31:56.875] Timer tick, asking Buildbucket for the build status
[04:31:57.461] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:57.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:53:0) after 1m0s
[04:32:57.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:53:0)
[04:32:57.508] Timer tick, asking Buildbucket for the build status
[04:32:57.589] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:57.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:54:0) after 1m0s
[04:33:57.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:54:0)
[04:33:57.686] Timer tick, asking Buildbucket for the build status
[04:33:57.865] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:57.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:55:0) after 1m0s
[04:34:57.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:55:0)
[04:34:57.934] Timer tick, asking Buildbucket for the build status
[04:34:58.026] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:56:0) after 1m0s
[04:35:58.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:56:0)
[04:35:58.199] Timer tick, asking Buildbucket for the build status
[04:35:58.349] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:58.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:57:0) after 1m0s
[04:36:58.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:57:0)
[04:36:58.403] Timer tick, asking Buildbucket for the build status
[04:36:58.536] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:58.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:58:0) after 1m0s
[04:37:58.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:58:0)
[04:37:58.578] Timer tick, asking Buildbucket for the build status
[04:37:58.660] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:58.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:59:0) after 1m0s
[04:38:58.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:59:0)
[04:38:58.790] Timer tick, asking Buildbucket for the build status
[04:38:58.911] Build 8887424539404924992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:58.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052854601559466272:60:0) after 1m0s
[04:39:45.730] Received PubSub notification, asking Buildbucket for the build status
[04:39:45.850] Build 8887424539404924992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:39:45.850] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582691984805815",
"created_by": "project:chromium",
"created_ts": "1582688499978017",
"id": "8887424539404924992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49ccb72a7dc27faa1c4724c34c220c23762cefe6\"}}",
"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-24-50e6\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169028, \"got_angle_revision\": \"27cb806ca81951b702740f3cb3a5193a9135e65b\", \"got_dawn_revision\": \"227568451b442ae16873ec23cd4b86cf28d00b2a\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"49ccb72a7dc27faa1c4724c34c220c23762cefe6\", \"got_revision_cp\": \"refs/heads/master@{#744529}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"da659b3741132fe6a6904e45d96112eef776bc28\", \"got_v8_revision\": \"57083a22efbe63d75af8adb979583fa3aa0ff0d4\", \"got_v8_revision_cp\": \"refs/heads/8.2.173@{#1}\", \"got_webrtc_revision\": \"a6db9c8fe9276774e3939d577c9320ad00fddd83\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49ccb72a7dc27faa1c4724c34c220c23762cefe6\", \"swarm_hashes_refs/heads/master(at){#744529}_without_patch\": {\"accessibility_unittests\": \"be8b049d1174c1cdc94f16a97ec6d38640e8329e\", \"angle_unittests\": \"f338b38085ed3cf9674fb76c10fa643846c88dcf\", \"app_shell_unittests\": \"99d0b1efaf760d22f7777809b9351d526ccbc168\", \"aura_unittests\": \"199bd9dd96d5fdb2144a436cd34a512a250d6b49\", \"base_unittests\": \"1e4c2b7aa313abc19f4e9d7187fbfbb81c627492\", \"base_util_unittests\": \"f2a3e5fe02659a290668e9eddbfa56387c9496c4\", \"blink_common_unittests\": \"350c07a66f81679936554b951bfa2fe22fba0d9b\", \"blink_fuzzer_unittests\": \"b1218bdc656601e05989b0a784b6db9610762f2c\", \"blink_heap_unittests\": \"2ec0a0ff833c1570592f250e50bcb3ffb688613f\", \"blink_platform_unittests\": \"91e5720426e6347a12b986a260d410e16887f655\", \"blink_python_tests\": \"bca77ab4a3bdc4ca763dca829c6baee146cac25c\", \"blink_unittests\": \"76a00ca3a5407212afe917161359df71b5239689\", \"blink_web_tests\": \"634147e0d08c75d369ab54ff22d2b668d6faa5d8\", \"boringssl_crypto_tests\": \"645c02bf39dae19547f5513dc91cf3121f370bc5\", \"boringssl_ssl_tests\": \"680b545f58a53d5f14df6792969b6bf4226f2cd6\", \"browser_tests\": \"dbf1188a6a1e9ce8d09edc622075a6e86390fa8a\", \"cacheinvalidation_unittests\": \"0340a0ffea3aa6050f1283cc35b9bae0ae565951\", \"capture_unittests\": \"d2499df43455580d862573fce65d6a7ca409221b\", \"cast_unittests\": \"ba61468e756c21ae32fae0733d15c30deeda39d1\", \"cc_unittests\": \"9beecec92825319ac8472b83c5ce93274aae6ac7\", \"chrome_app_unittests\": \"f3796c14db7582329ca88ed505b1f1469e7504ab\", \"chromedriver_unittests\": \"1b9fa9bae6ca573b16f6fec7ea33c8bdc20ded38\", \"components_browsertests\": \"9ebecd04e7e2f85d8cf5436e377df96de0b4d811\", \"components_unittests\": \"808f846756d0f0914a20809fa3e553172c2342fa\", \"compositor_unittests\": \"2e4b0181412d8cf08fe3e55a15a45fd7534e8248\", \"content_browsertests\": \"5420b2d3e99288688ff8738959f8890b05caa946\", \"content_shell_crash_test\": \"e3e5b17abc71099264cde806df5ee320bc926637\", \"content_unittests\": \"cfe297eda850b1de53da2760fb5f819dc9f6c1bf\", \"crashpad_tests\": \"52335fcbe2846a4f04c4973574ff2c35ba7695f4\", \"cronet_tests\": \"8182c3a7c9f5618aeb02246076cd2c2282ed6960\", \"cronet_unittests\": \"5ed0016a290004c9d7f4ba534b6aa5b803d666e6\", \"crypto_unittests\": \"4209ffb1829140412c01b5fb5dfc9db66cdc5a64\", \"dbus_unittests\": \"a1faf5babb02551015ccba38832091bca700a399\", \"device_unittests\": \"b5931f3e5be26084dc81b1a20e5e8485fe2a407c\", \"display_unittests\": \"a2522d2ef73cb96e9edde6edfb4d1ff62a7203bd\", \"events_unittests\": \"e226c433b0b666c6c77ea89a0a2bfa995a62d088\", \"extensions_browsertests\": \"d6bc21c44de392503e6eca14caccd26d75123f83\", \"extensions_unittests\": \"416b27e851d376e215a2ee73db4aa54dd7041995\", \"filesystem_service_unittests\": \"808deb351fb3bd88db7c537dfcfc4f758e58a49c\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"37930532d3ccdcfdd4c51b621e9563f511c08649\", \"gfx_unittests\": \"10f2e521580e56bc70fac8943974d54b23a493d7\", \"gin_unittests\": \"f85f930f4c7e2700709157f4e7fd65bbaa841aa9\", \"google_apis_unittests\": \"c4c6a1cc732fccac31ef090ac8c161bb5f2337f4\", \"gpu_unittests\": \"73adc8604c64e1bf81d8975883580815afdc67e1\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"f9931a1c16bf0385d9a1e68694ebb3efa12b0be6\", \"headless_browsertests\": \"d8684a900fb5d3d2cf4d4e877ac43fe32694cdc8\", \"headless_unittests\": \"483a0c33dfe7e9ecd183b89d8bb357713b30845d\", \"interactive_ui_tests\": \"f30b612f5b63f411be8eb2bda6b2b2b95ec9dafd\", \"ipc_tests\": \"9fc0e8262c9515f2f90026e87294f31fb169c81c\", \"jingle_unittests\": \"03c490e4162933da728a66a72a704fba316fa777\", \"latency_unittests\": \"d047ddb8cc79a750814853f0570b10242bbda35f\", \"libjingle_xmpp_unittests\": \"f161e3c75b454e72ff0fc0b413426003ef953725\", \"media_blink_unittests\": \"44ff35e52652062a6a9b90b55cb99b2d30ddfc46\", \"media_service_unittests\": \"58f7c6386a1d5fadfc8997ca50284b8ba3461bfc\", \"media_unittests\": \"17484393e78d56962b14d39c970fb39325e110ce\", \"message_center_unittests\": \"68555c9ca02adc9034cf7b041523c3c26baac4f3\", \"metrics_python_tests\": \"74b1f9c51dc189cc347d1c3007bd3a8fb22a968c\", \"midi_unittests\": \"ea3b618a64212a0875e21f9de3d5e42bbc7e3350\", \"mojo_core_unittests\": \"1bb1e648ef92fa8977968ad2744e53982c4ec9b6\", \"mojo_unittests\": \"c66d1ff4e557159961cf564f502006578803ba00\", \"nacl_helper_nonsfi_unittests\": \"f2e81d6cb41bb06d2bdca4a2ed0d77f22a887857\", \"nacl_loader_unittests\": \"59ae75e555d5afb37524da646516b595462ceabc\", \"native_theme_unittests\": \"695dc9d6c0f80e8db8a3b70fce8bb2a6fd179088\", \"net_unittests\": \"f18992e58b06a316d3e90495502cd84ae43c6f6b\", \"pdf_unittests\": \"900154cb1f48224d65eb14a5b5edc68e5b2faeb5\", \"perfetto_unittests\": \"a342937254cacf69269a4fc2c69c97c27ac25a92\", \"ppapi_unittests\": \"11c2a6c43191b1da1850abb6386b0a16206633bf\", \"printing_unittests\": \"6c8b2167ae61fdcd27ec2510a8eebb1f99e3f57b\", \"remoting_unittests\": \"ef0bc88d109449e654717fcb34a44378c43b773f\", \"sandbox_linux_unittests\": \"982bef5f630b96d488bb8d52d6c3a0af9d30a657\", \"service_manager_unittests\": \"31f5b11413179f304fe3ab79200cc931d7ef2d2e\", \"services_unittests\": \"8c10dccdbf0538f57c693a14edd20fce7a329f0e\", \"shell_dialogs_unittests\": \"bc731a9ca51d871ddda6972ca6fc822c4fcbd998\", \"skia_unittests\": \"a83ce049fc5688c50ea33b5c883059b421547b19\", \"snapshot_unittests\": \"3728401f9ae1ad006a58947fd7c95c9e2d9f0d8f\", \"sql_unittests\": \"3e3bc20e2d831bae044cd01f0f80041320572d1e\", \"storage_unittests\": \"a093fc012c897dba3bc9fb827160bd05c72d3c05\", \"sync_integration_tests\": \"4e1a0a045b3b82051addc7b36ca0f4160c6dc69a\", \"telemetry_gpu_unittests\": \"eabf356fc4c3f4cbe035f31a3a8c094211107e2f\", \"telemetry_perf_unittests\": \"b8fdf525500d99fc2263fa4827aae8089c60452a\", \"telemetry_unittests\": \"3328af823f523ac4c63e8ebeeaa442194c27115f\", \"traffic_annotation_auditor_unittests\": \"7bac54b8d589cf726834e4c483137365f97bf2dd\", \"ui_base_unittests\": \"c2ad3dcc3fa680df3089ef230f71b3348b6d9ba5\", \"ui_touch_selection_unittests\": \"e35634f00a31ff1cf6ee67e12823de9f7bdc3287\", \"unit_tests\": \"1c4d400c49af3d5cdeb17a4ef70daf68a4dafb01\", \"url_unittests\": \"ab296c42a08b0eb54c68094786edc60c14a67b20\", \"views_perftests\": \"ec54e427d6419c370ea4ca7c08d60b424e93c170\", \"views_unittests\": \"32dbd181686c7677bea6e81d919bf914ce9dd3bf\", \"viz_unittests\": \"bb7f33336d78354b71a8875f08bcb71a8c2e1d15\", \"vr_common_unittests\": \"bba52a758495ea4e9746f7d2bfe48178527d3f4a\", \"vr_pixeltests\": \"ae8f69838db5bda7ddcb2b4f6258dc37a9691979\", \"webdriver_wpt_tests\": \"2a4d23127fa99cb369b1f4c18a0a747cc5052ae1\", \"weblayer_browsertests\": \"c96903aa6f966ef5db132dde91f50dba23402333\", \"wm_unittests\": \"aba0ad0faff78add0088e163c742bc4836ac6098\", \"wtf_unittests\": \"6bffdeb5bfa523f4cba826a2ca87005a57208d0f\", \"xr_browser_tests\": \"35af379a5f8c52090d0c3c021e7260546022d30d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_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-24-50e6\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582688766770307",
"status": "COMPLETED",
"status_changed_ts": "1582691985367010",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169028",
"builder:Linux Builder (dbg)",
"buildset:commit/git/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49ccb72a7dc27faa1c4724c34c220c23762cefe6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052854601559466272",
"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/8887424539404924992/+/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:4a986786abea6c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582691985371484",
"url": "https://ci.chromium.org/b/8887424539404924992",
"utcnow_ts": "1582691985838863"
}
}
[04:39:45.850] Invocation finished in 58m7.310313521s with status SUCCEEDED