[15:06:53.052] New invocation is queued and will start shortly
[15:06:54.329] Starting the invocation (attempt 1)
[15:06:54.383] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:06:54.383] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:06:54.384] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029528069522736576",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9029528069522736576",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"gitiles_ref:refs/heads/master"
]
}
[15:06:55.976] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604934414590083",
"id": "8864098007244959488",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604934415840454",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177506",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029528069522736576",
"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/8864098007244959488/+/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": "1604934415840607",
"url": "https://ci.chromium.org/b/8864098007244959488",
"utcnow_ts": "1604934415962640"
}
}
[15:06:55.976] Task URL: https://ci.chromium.org/b/8864098007244959488
[15:06:55.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:2:0) after 1m0s
[15:07:51.184] Received PubSub notification, asking Buildbucket for the build status
[15:07:51.364] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:00.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:2:0)
[15:08:00.971] Timer tick, asking Buildbucket for the build status
[15:08:01.111] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:01.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:4:0) after 1m0s
[15:09:01.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:4:0)
[15:09:01.189] Timer tick, asking Buildbucket for the build status
[15:09:01.457] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:01.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:5:0) after 1m0s
[15:10:03.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:5:0)
[15:10:03.406] Timer tick, asking Buildbucket for the build status
[15:10:03.967] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:03.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:6:0) after 1m0s
[15:11:04.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:6:0)
[15:11:04.018] Timer tick, asking Buildbucket for the build status
[15:11:04.157] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:7:0) after 1m0s
[15:12:04.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:7:0)
[15:12:04.409] Timer tick, asking Buildbucket for the build status
[15:12:04.613] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:04.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:8:0) after 1m0s
[15:13:04.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:8:0)
[15:13:04.714] Timer tick, asking Buildbucket for the build status
[15:13:05.172] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:05.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:9:0) after 1m0s
[15:14:05.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:9:0)
[15:14:05.387] Timer tick, asking Buildbucket for the build status
[15:14:05.496] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:05.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:10:0) after 1m0s
[15:15:05.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:10:0)
[15:15:05.668] Timer tick, asking Buildbucket for the build status
[15:15:06.502] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:06.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:11:0) after 1m0s
[15:16:06.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:11:0)
[15:16:06.769] Timer tick, asking Buildbucket for the build status
[15:16:06.931] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:06.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:12:0) after 1m0s
[15:17:07.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:12:0)
[15:17:07.037] Timer tick, asking Buildbucket for the build status
[15:17:08.141] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:08.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:13:0) after 1m0s
[15:18:08.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:13:0)
[15:18:08.273] Timer tick, asking Buildbucket for the build status
[15:18:08.450] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:08.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:14:0) after 1m0s
[15:19:08.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:14:0)
[15:19:08.673] Timer tick, asking Buildbucket for the build status
[15:19:08.751] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:08.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:15:0) after 1m0s
[15:20:09.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:15:0)
[15:20:09.027] Timer tick, asking Buildbucket for the build status
[15:20:10.134] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:10.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:16:0) after 1m0s
[15:21:10.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:16:0)
[15:21:10.292] Timer tick, asking Buildbucket for the build status
[15:21:10.356] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:10.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:17:0) after 1m0s
[15:22:10.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:17:0)
[15:22:10.442] Timer tick, asking Buildbucket for the build status
[15:22:10.513] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:18:0) after 1m0s
[15:23:10.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:18:0)
[15:23:10.518] Timer tick, asking Buildbucket for the build status
[15:23:10.617] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:10.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:19:0) after 1m0s
[15:24:10.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:19:0)
[15:24:10.696] Timer tick, asking Buildbucket for the build status
[15:24:11.012] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:11.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:20:0) after 1m0s
[15:25:11.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:20:0)
[15:25:11.092] Timer tick, asking Buildbucket for the build status
[15:25:11.167] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:21:0) after 1m0s
[15:26:11.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:21:0)
[15:26:11.218] Timer tick, asking Buildbucket for the build status
[15:26:11.313] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:11.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:22:0) after 1m0s
[15:27:11.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:22:0)
[15:27:11.372] Timer tick, asking Buildbucket for the build status
[15:27:11.471] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:11.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:23:0) after 1m0s
[15:28:11.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:23:0)
[15:28:11.568] Timer tick, asking Buildbucket for the build status
[15:28:11.709] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:11.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:24:0) after 1m0s
[15:29:11.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:24:0)
[15:29:11.801] Timer tick, asking Buildbucket for the build status
[15:29:11.886] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:11.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:25:0) after 1m0s
[15:30:12.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:25:0)
[15:30:12.125] Timer tick, asking Buildbucket for the build status
[15:30:12.199] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:12.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:26:0) after 1m0s
[15:31:12.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:26:0)
[15:31:12.266] Timer tick, asking Buildbucket for the build status
[15:31:12.367] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:12.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:27:0) after 1m0s
[15:32:12.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:27:0)
[15:32:12.590] Timer tick, asking Buildbucket for the build status
[15:32:12.659] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:12.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:28:0) after 1m0s
[15:33:12.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:28:0)
[15:33:12.920] Timer tick, asking Buildbucket for the build status
[15:33:13.342] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:13.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:29:0) after 1m0s
[15:34:13.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:29:0)
[15:34:13.581] Timer tick, asking Buildbucket for the build status
[15:34:13.841] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:13.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:30:0) after 1m0s
[15:35:14.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:30:0)
[15:35:14.354] Timer tick, asking Buildbucket for the build status
[15:35:14.431] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:14.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:31:0) after 1m0s
[15:36:14.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:31:0)
[15:36:14.557] Timer tick, asking Buildbucket for the build status
[15:36:14.622] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:32:0) after 1m0s
[15:37:14.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:32:0)
[15:37:14.740] Timer tick, asking Buildbucket for the build status
[15:37:15.170] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:15.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:33:0) after 1m0s
[15:38:15.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:33:0)
[15:38:15.627] Timer tick, asking Buildbucket for the build status
[15:38:15.888] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:15.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:34:0) after 1m0s
[15:39:15.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:34:0)
[15:39:15.975] Timer tick, asking Buildbucket for the build status
[15:39:16.228] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:16.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:35:0) after 1m0s
[15:40:16.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:35:0)
[15:40:16.395] Timer tick, asking Buildbucket for the build status
[15:40:16.533] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:16.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:36:0) after 1m0s
[15:41:16.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:36:0)
[15:41:16.595] Timer tick, asking Buildbucket for the build status
[15:41:16.695] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:16.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:37:0) after 1m0s
[15:42:16.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:37:0)
[15:42:16.763] Timer tick, asking Buildbucket for the build status
[15:42:16.835] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:16.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:38:0) after 1m0s
[15:43:16.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:38:0)
[15:43:16.968] Timer tick, asking Buildbucket for the build status
[15:43:17.104] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:17.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:39:0) after 1m0s
[15:44:17.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:39:0)
[15:44:17.167] Timer tick, asking Buildbucket for the build status
[15:44:17.371] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:17.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:40:0) after 1m0s
[15:45:17.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:40:0)
[15:45:17.407] Timer tick, asking Buildbucket for the build status
[15:45:17.513] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:17.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:41:0) after 1m0s
[15:46:17.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:41:0)
[15:46:17.593] Timer tick, asking Buildbucket for the build status
[15:46:17.673] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:17.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:42:0) after 1m0s
[15:47:17.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:42:0)
[15:47:17.793] Timer tick, asking Buildbucket for the build status
[15:47:18.169] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:18.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:43:0) after 1m0s
[15:48:18.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:43:0)
[15:48:18.210] Timer tick, asking Buildbucket for the build status
[15:48:19.076] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:44:0) after 1m0s
[15:49:19.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:44:0)
[15:49:19.078] Timer tick, asking Buildbucket for the build status
[15:49:19.316] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:19.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:45:0) after 1m0s
[15:50:19.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:45:0)
[15:50:19.454] Timer tick, asking Buildbucket for the build status
[15:50:19.779] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:19.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:46:0) after 1m0s
[15:51:19.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:46:0)
[15:51:19.804] Timer tick, asking Buildbucket for the build status
[15:51:19.900] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:19.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:47:0) after 1m0s
[15:52:19.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:47:0)
[15:52:19.970] Timer tick, asking Buildbucket for the build status
[15:52:20.122] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:20.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:48:0) after 1m0s
[15:53:20.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:48:0)
[15:53:20.229] Timer tick, asking Buildbucket for the build status
[15:53:20.435] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:20.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:49:0) after 1m0s
[15:54:20.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:49:0)
[15:54:20.425] Timer tick, asking Buildbucket for the build status
[15:54:20.659] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:20.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:50:0) after 1m0s
[15:55:20.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:50:0)
[15:55:20.751] Timer tick, asking Buildbucket for the build status
[15:55:21.019] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:21.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:51:0) after 1m0s
[15:56:21.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:51:0)
[15:56:21.141] Timer tick, asking Buildbucket for the build status
[15:56:21.215] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:52:0) after 1m0s
[15:57:21.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:52:0)
[15:57:21.244] Timer tick, asking Buildbucket for the build status
[15:57:21.404] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:21.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:53:0) after 1m0s
[15:58:21.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:53:0)
[15:58:21.570] Timer tick, asking Buildbucket for the build status
[15:58:21.784] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:21.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:54:0) after 1m0s
[15:59:21.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:54:0)
[15:59:21.834] Timer tick, asking Buildbucket for the build status
[15:59:21.927] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:55:0) after 1m0s
[16:00:21.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:55:0)
[16:00:21.992] Timer tick, asking Buildbucket for the build status
[16:00:22.213] Build 8864098007244959488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:22.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029528069522736576:56:0) after 1m0s
[16:01:01.886] Received PubSub notification, asking Buildbucket for the build status
[16:01:04.258] Build 8864098007244959488: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:01:04.258] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604937660586865",
"created_by": "project:chromium",
"created_ts": "1604934414590083",
"id": "8864098007244959488",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\", \"project\": \"chromium/src\"}], \"$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-83-u1wy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177506, \"got_angle_revision\": \"46f5f4386f7c7489a66884b9062287a7cb9798de\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\", \"got_revision_cp\": \"refs/heads/master@{#825329}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"b01fdf67620796b3498f657b5ba71d34cfddccb1\", \"got_v8_revision_cp\": \"refs/heads/8.8.258@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef4e919472b5d3392ee0a203eb127cbbdfca18d2\", \"swarm_hashes_refs/heads/master(at){#825329}_without_patch\": {\"absl_hardening_tests\": \"f899cc153f8f6be08655ab4283ea11bce01d03f6\", \"accessibility_unittests\": \"dc6e7a6640e797f6f6822070bb51eda405d0f030\", \"angle_unittests\": \"deecea8b62545dc7daa8159439f63bfb24131f09\", \"app_shell_unittests\": \"a08c8d4392276498a17551c35dae41b6c7dc78c1\", \"aura_unittests\": \"fb657bd9e0e8e5671a8e45ad90cfbbc2e1f47166\", \"base_unittests\": \"baa030c79b71a33209c6fb25b1489db9ebbf3844\", \"base_util_unittests\": \"c7c8dd3093e8dbcaf2d2360eb111a4cee95f342c\", \"blink_common_unittests\": \"8cd1f9c6def6835dd01424fc1bb98e602c0b4fc4\", \"blink_fuzzer_unittests\": \"fa3d2fc6f6ede6f184f08fe0087c4f05e773d6bb\", \"blink_heap_unittests\": \"60e1bf4579222ccb0131faab97d70c64427e9244\", \"blink_platform_unittests\": \"cf5a177710982a97e103f8aa8802b1888edc2891\", \"blink_python_tests\": \"2bdd45e2405805f9c3aef3381b17828d3b888eae\", \"blink_unittests\": \"8d3bf361d1be4df94eb3f8037d5448403402980e\", \"blink_web_tests\": \"bd995f1b0f24cea4752efb0895fc76dc926c9949\", \"boringssl_crypto_tests\": \"37af0af8616d8f6a789dd7dc8c1dc65dafbce862\", \"boringssl_ssl_tests\": \"987957c6a1e91f93d510c42c89e4f4941dea9bb7\", \"browser_tests\": \"c4aec6a9520113ef48751ba39cf6424a73ab40d4\", \"capture_unittests\": \"95cd6116f47fe4a70ef0799ed6e09488409780db\", \"cast_unittests\": \"b525b624cf20f89be62a2e9c60a8ad833f776d16\", \"cc_unittests\": \"629ca6f1c5f71dcaee5413cfdc9fa7c5e4d6acda\", \"chrome_app_unittests\": \"1e0a99d28d92071b14314255d34199f87a1ab52a\", \"chromedriver_unittests\": \"cf7901eeb011c8e92bfd50d8956ae18ca75211f2\", \"components_browsertests\": \"e8cd775266a0484c150d4fd2779022e3560adb29\", \"components_unittests\": \"2367ebf60ffba0343fbd8b736cfadad2159d823b\", \"compositor_unittests\": \"fab0b65a14e188a8ce6327b24ca83e94be9f3c05\", \"content_browsertests\": \"3056022aa5ce5a85c2e06997a4758e7518ab7878\", \"content_shell_crash_test\": \"2d217eeaaaacc6f1319307537bb082e66144c324\", \"content_unittests\": \"efad21cff793c897209f901db1518dc5d3907feb\", \"crashpad_tests\": \"b51cf2a6daa4966e73691475e87d193274e9b145\", \"cronet_tests\": \"caeca8c2d7451920ad5658a81620c0d6e15097e9\", \"cronet_unittests\": \"a2eaa7d9c7a816874537c20b6f6b09677678747e\", \"crypto_unittests\": \"5d4b6f76e399987bdb2ddcdc65ffc6219b37caa7\", \"dbus_unittests\": \"9f54d0bafc15fcc4bb5bd7b9517a14d00f8c651f\", \"device_unittests\": \"35b7c5996d0e200f5412f64510508626ef2bfe04\", \"display_unittests\": \"b06f7134411adb79eb6584bfee10ffd02bd5b89f\", \"events_unittests\": \"67507ba5f02f11ec727d54f7d2f3889e372b52d3\", \"extension_docserver_python_unittests\": \"6f40029e64b66a2f141f4c6b6c7c5821fe987351\", \"extensions_browsertests\": \"2902f7ef96a466d665dab5ab115abdf3e14aeec0\", \"extensions_unittests\": \"ba3ec829f6bf83ceba49dc4172973a40694fe286\", \"filesystem_service_unittests\": \"804c86396498b5baa65084f74ebb4a051b2d7fc4\", \"flatbuffers_unittests\": \"a75979d220fd6e42d14b6fb920789a229acd99ec\", \"gcm_unit_tests\": \"0658b6ecca26a2389c6498115262d56d51e727e2\", \"gfx_unittests\": \"ed7219c2265ed90d12bdcaad1856051191d46cd6\", \"gin_unittests\": \"ce7deb77daf335a7fe994a50e30011412eb720be\", \"google_apis_unittests\": \"7db324908e56c6bea700e174f7fd2a3252ab6e9f\", \"gpu_unittests\": \"ef8881b68bfdbe95c6aa0abcb48f525cf0fe0370\", \"grit_python_unittests\": \"c07986f763d334409a8503f4ad401722aef8de4c\", \"gwp_asan_unittests\": \"e98d64c983814a4b1ceb9dcf4519d486f59fe823\", \"headless_browsertests\": \"536423d12be58839d1e6b105836625b18ec882f7\", \"headless_unittests\": \"14420b77cd8a35d683c2dfa4b2feb3b057e965de\", \"interactive_ui_tests\": \"ca543567afc2cbe6ed340602697f949b905f1dcf\", \"ipc_tests\": \"f3691e093f5e1499fc1b0093004e6fc7dadae527\", \"jingle_unittests\": \"9727d9ad8bd907a2db289e07022882993533d0e5\", \"latency_unittests\": \"d064b9c8d469640d9ee829a507bcc25b2ef0f1a5\", \"libjingle_xmpp_unittests\": \"e35ce0a5c7b324072bd6dc4819b814680bc78e2b\", \"liburlpattern_unittests\": \"da7c542b6c23e90ec1e0701b6feea27485a19c35\", \"media_blink_unittests\": \"dee7291e1140a7e2a433d95efaa242c0b961cda0\", \"media_unittests\": \"b05b87136d810ee8080a0437789bf1ed44ecfc06\", \"message_center_unittests\": \"c32116f0ad0fc9577874a30df45db9aa4778d429\", \"metrics_python_tests\": \"a03338a31a2e38ccf2550a9b1a59a27a8d99cc16\", \"midi_unittests\": \"db49d012e5e63eac1309514a29bbcc0fc698c2df\", \"mojo_core_unittests\": \"0149e9d7a2de2b19fa3216bdf99c323dcf06c9f4\", \"mojo_unittests\": \"c950c864a339200af7c3f39419516d0196294304\", \"nacl_helper_nonsfi_unittests\": \"a71615cb9f0fc0c4c4360911d325ac60f46a7cff\", \"nacl_loader_unittests\": \"f9e0dc1d7c69e8f40ab2e5f6fc5eb861363688bd\", \"native_theme_unittests\": \"fbc2c7882982bdafaba33ffb776dc3912bfb0881\", \"net_unittests\": \"5bb222d5e43a471300e1b9b9bbadb72a2f7828be\", \"openscreen_unittests\": \"1e717446da354e43aaffcfc7b9342a5da5d52fca\", \"pdf_unittests\": \"81698187b911fd806956eec28416a5fcd6651f93\", \"perfetto_unittests\": \"9090a139025778c262c48e707c8da033a084f7e8\", \"ppapi_unittests\": \"133c58c8b44706cc6ecfb2ee07988a1bc2bac87a\", \"printing_unittests\": \"793fb7d09be9a12a39a1a5314cda5ae9de70211a\", \"remoting_unittests\": \"4e4203c54db020d20e7e36abe1441faee06863c1\", \"sandbox_linux_unittests\": \"895a3c69f335a40ab14a713d66a10c4527d49202\", \"service_manager_unittests\": \"8709899fe6f3f020b62a7ecd87dc26d1c6f845f2\", \"services_unittests\": \"15df0b220fefd9cc781fc4b8db550007f4bcfa53\", \"shell_dialogs_unittests\": \"054ee9b0247de4d91b40c21d84e9243d21e3953c\", \"skia_unittests\": \"3fdf5a603f40480721c9fe6d8e8fb373b5b6a276\", \"snapshot_unittests\": \"e12895cfc0b15d62ac290ea36b43e1ea35a99eea\", \"sql_unittests\": \"37a938f175c5c5feefd89cf2048b6959f3579c8c\", \"storage_unittests\": \"46930be383469d488fdfc738506da62c4421c626\", \"sync_integration_tests\": \"600c38650f026aa312b82732ff4b6935dd168a54\", \"telemetry_gpu_unittests\": \"de7dcf57595166f11f9fed9b6c6c356f9a889148\", \"telemetry_perf_unittests\": \"6bf4bb213d837fa2ca73c07135939bbad100a3ef\", \"telemetry_unittests\": \"dd542cb4250e03e6cf2317420822f201dc8752e7\", \"traffic_annotation_auditor_unittests\": \"7d608727cbc39ab1baf92f3cc29920dc1b5140a5\", \"ui_base_unittests\": \"3caebcebd01b85a5abf3a76243861620074ca0cc\", \"ui_touch_selection_unittests\": \"33df3cd5f009e094879fe744d80fe17413f624fe\", \"unit_tests\": \"bc7dc23b9b24ae84431c64f7fc8e32ef7aa27e2b\", \"url_unittests\": \"58d01096fe4cf2c68711bb2e9c8249b349f48d9c\", \"views_perftests\": \"13d8f09829944e88d7a44bd4f5a480b26d007d8a\", \"views_unittests\": \"4ea44072d02adaf232c326615120ad908657c300\", \"viz_unittests\": \"0664bb69c46d2c809889d14fc249e85db34c2bfd\", \"vr_common_unittests\": \"5120b9b2e942d856652ab9e570c5866a0772a565\", \"vr_pixeltests\": \"d8df2eda5414cba1338c3fa40b7455fa7e33be18\", \"webdriver_wpt_tests\": \"98bced2cee3c3439fa0fc77df56e879b2976505f\", \"weblayer_browsertests\": \"d1c009ca667983d80c58c058aa00ebef6d4e9633\", \"weblayer_unittests\": \"3ae3e104d05cbcf1cf9b3e8aabc9726dd3f19c70\", \"wm_unittests\": \"dde199ca728826fcb7d129224bde0b90a89c2ce4\", \"wtf_unittests\": \"31c4ed9357834365e5be72a1bd77ff5e0f59fbe1\", \"x11_unittests\": \"6daf9ce469fb80182e729be6b7fac6fdaa15cf5f\", \"xr_browser_tests\": \"262754c9a86222e1d89993a3d1006879ec504a3c\", \"zlib_unittests\": \"3e05fa3ba9a6c01cd997836d4d063c91f32c3468\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-83-u1wy\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604934470040935",
"status": "COMPLETED",
"status_changed_ts": "1604937661675291",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177506",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef4e919472b5d3392ee0a203eb127cbbdfca18d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029528069522736576",
"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/8864098007244959488/+/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:4fc65d8e63917210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604937661685994",
"url": "https://ci.chromium.org/b/8864098007244959488",
"utcnow_ts": "1604937664178822"
}
}
[16:01:04.258] Invocation finished in 54m11.223959757s with status SUCCEEDED