[01:29:28.580] New invocation is queued and will start shortly
[01:29:29.623] Starting the invocation (attempt 1)
[01:29:29.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:29.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:29.663] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017983084677127680",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9017983084677127680",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"gitiles_ref:refs/heads/master"
]
}
[01:29:30.323] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615944569800890",
"id": "8852553022735402032",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615944570219933",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/26824",
"builder:Linux Viz",
"buildset:commit/git/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017983084677127680",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852553022735402032/+/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": "1615944570220095",
"url": "https://ci.chromium.org/b/8852553022735402032",
"utcnow_ts": "1615944570317928"
}
}
[01:29:30.323] Task URL: https://ci.chromium.org/b/8852553022735402032
[01:29:30.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:2:0) after 1m0s
[01:30:30.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:2:0)
[01:30:30.409] Timer tick, asking Buildbucket for the build status
[01:30:30.506] Build 8852553022735402032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:30.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:3:0) after 1m0s
[01:31:24.940] Received PubSub notification, asking Buildbucket for the build status
[01:31:25.040] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:30.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:3:0)
[01:31:30.577] Timer tick, asking Buildbucket for the build status
[01:31:30.704] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:30.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:5:0) after 1m0s
[01:32:30.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:5:0)
[01:32:30.723] Timer tick, asking Buildbucket for the build status
[01:32:30.986] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:30.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:6:0) after 1m0s
[01:33:30.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:6:0)
[01:33:30.989] Timer tick, asking Buildbucket for the build status
[01:33:31.054] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:7:0) after 1m0s
[01:34:31.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:7:0)
[01:34:31.062] Timer tick, asking Buildbucket for the build status
[01:34:31.145] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:31.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:8:0) after 1m0s
[01:35:31.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:8:0)
[01:35:31.198] Timer tick, asking Buildbucket for the build status
[01:35:31.278] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:9:0) after 1m0s
[01:36:31.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:9:0)
[01:36:31.367] Timer tick, asking Buildbucket for the build status
[01:36:31.534] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:31.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:10:0) after 1m0s
[01:37:31.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:10:0)
[01:37:31.563] Timer tick, asking Buildbucket for the build status
[01:37:31.638] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:31.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:11:0) after 1m0s
[01:38:31.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:11:0)
[01:38:31.705] Timer tick, asking Buildbucket for the build status
[01:38:31.781] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:31.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:12:0) after 1m0s
[01:39:31.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:12:0)
[01:39:31.860] Timer tick, asking Buildbucket for the build status
[01:39:32.029] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:32.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:13:0) after 1m0s
[01:40:32.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:13:0)
[01:40:32.009] Timer tick, asking Buildbucket for the build status
[01:40:32.085] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:32.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:14:0) after 1m0s
[01:41:32.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:14:0)
[01:41:32.368] Timer tick, asking Buildbucket for the build status
[01:41:32.453] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:32.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:15:0) after 1m0s
[01:42:32.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:15:0)
[01:42:32.513] Timer tick, asking Buildbucket for the build status
[01:42:32.584] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:32.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:16:0) after 1m0s
[01:43:32.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:16:0)
[01:43:32.683] Timer tick, asking Buildbucket for the build status
[01:43:32.929] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:32.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:17:0) after 1m0s
[01:44:33.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:17:0)
[01:44:33.131] Timer tick, asking Buildbucket for the build status
[01:44:33.214] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:33.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:18:0) after 1m0s
[01:45:33.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:18:0)
[01:45:33.591] Timer tick, asking Buildbucket for the build status
[01:45:33.663] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:19:0) after 1m0s
[01:46:34.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:19:0)
[01:46:34.065] Timer tick, asking Buildbucket for the build status
[01:46:34.663] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:34.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:20:0) after 1m0s
[01:47:34.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:20:0)
[01:47:34.699] Timer tick, asking Buildbucket for the build status
[01:47:34.759] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:34.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:21:0) after 1m0s
[01:48:35.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:21:0)
[01:48:35.182] Timer tick, asking Buildbucket for the build status
[01:48:35.257] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:35.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:22:0) after 1m0s
[01:49:36.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:22:0)
[01:49:36.068] Timer tick, asking Buildbucket for the build status
[01:49:36.152] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:36.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:23:0) after 1m0s
[01:50:36.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:23:0)
[01:50:36.361] Timer tick, asking Buildbucket for the build status
[01:50:36.455] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:36.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:24:0) after 1m0s
[01:51:36.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:24:0)
[01:51:36.799] Timer tick, asking Buildbucket for the build status
[01:51:36.863] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:36.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:25:0) after 1m0s
[01:52:37.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:25:0)
[01:52:37.024] Timer tick, asking Buildbucket for the build status
[01:52:37.117] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:37.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:26:0) after 1m0s
[01:53:37.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:26:0)
[01:53:37.189] Timer tick, asking Buildbucket for the build status
[01:53:37.250] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:37.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:27:0) after 1m0s
[01:54:37.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:27:0)
[01:54:37.338] Timer tick, asking Buildbucket for the build status
[01:54:37.413] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:37.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:28:0) after 1m0s
[01:55:37.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:28:0)
[01:55:37.464] Timer tick, asking Buildbucket for the build status
[01:55:37.533] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:37.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:29:0) after 1m0s
[01:56:37.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:29:0)
[01:56:37.690] Timer tick, asking Buildbucket for the build status
[01:56:37.754] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:37.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:30:0) after 1m0s
[01:57:37.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:30:0)
[01:57:37.845] Timer tick, asking Buildbucket for the build status
[01:57:37.945] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:31:0) after 1m0s
[01:58:38.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:31:0)
[01:58:38.054] Timer tick, asking Buildbucket for the build status
[01:58:39.538] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:39.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:32:0) after 1m0s
[01:59:39.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:32:0)
[01:59:39.541] Timer tick, asking Buildbucket for the build status
[01:59:39.699] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:39.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:33:0) after 1m0s
[02:00:39.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:33:0)
[02:00:39.756] Timer tick, asking Buildbucket for the build status
[02:00:40.140] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:40.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:34:0) after 1m0s
[02:01:40.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:34:0)
[02:01:40.216] Timer tick, asking Buildbucket for the build status
[02:01:40.296] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:40.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:35:0) after 1m0s
[02:02:40.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:35:0)
[02:02:40.313] Timer tick, asking Buildbucket for the build status
[02:02:40.380] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:40.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:36:0) after 1m0s
[02:03:40.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:36:0)
[02:03:40.441] Timer tick, asking Buildbucket for the build status
[02:03:40.516] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:37:0) after 1m0s
[02:04:40.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:37:0)
[02:04:40.518] Timer tick, asking Buildbucket for the build status
[02:04:40.652] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:40.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:38:0) after 1m0s
[02:05:40.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:38:0)
[02:05:40.736] Timer tick, asking Buildbucket for the build status
[02:05:40.803] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:40.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:39:0) after 1m0s
[02:06:40.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:39:0)
[02:06:40.906] Timer tick, asking Buildbucket for the build status
[02:06:40.968] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:40.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:40:0) after 1m0s
[02:07:41.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:40:0)
[02:07:41.114] Timer tick, asking Buildbucket for the build status
[02:07:41.223] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:41:0) after 1m0s
[02:08:41.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:41:0)
[02:08:41.273] Timer tick, asking Buildbucket for the build status
[02:08:41.343] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:41.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:42:0) after 1m0s
[02:09:41.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:42:0)
[02:09:41.461] Timer tick, asking Buildbucket for the build status
[02:09:41.550] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:41.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:43:0) after 1m0s
[02:10:41.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:43:0)
[02:10:41.576] Timer tick, asking Buildbucket for the build status
[02:10:41.644] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:41.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:44:0) after 1m0s
[02:11:41.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:44:0)
[02:11:41.667] Timer tick, asking Buildbucket for the build status
[02:11:41.733] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:41.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:45:0) after 1m0s
[02:12:41.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:45:0)
[02:12:41.781] Timer tick, asking Buildbucket for the build status
[02:12:41.844] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:41.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:46:0) after 1m0s
[02:13:41.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:46:0)
[02:13:41.913] Timer tick, asking Buildbucket for the build status
[02:13:41.979] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:41.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:47:0) after 1m0s
[02:14:42.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:47:0)
[02:14:42.069] Timer tick, asking Buildbucket for the build status
[02:14:42.154] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:42.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:48:0) after 1m0s
[02:15:42.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:48:0)
[02:15:42.158] Timer tick, asking Buildbucket for the build status
[02:15:42.282] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:49:0) after 1m0s
[02:16:42.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:49:0)
[02:16:42.327] Timer tick, asking Buildbucket for the build status
[02:16:42.386] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:42.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:50:0) after 1m0s
[02:17:42.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:50:0)
[02:17:42.419] Timer tick, asking Buildbucket for the build status
[02:17:42.479] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:42.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:51:0) after 1m0s
[02:18:42.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:51:0)
[02:18:42.519] Timer tick, asking Buildbucket for the build status
[02:18:42.768] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:42.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:52:0) after 1m0s
[02:19:42.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:52:0)
[02:19:42.789] Timer tick, asking Buildbucket for the build status
[02:19:42.983] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:53:0) after 1m0s
[02:20:43.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:53:0)
[02:20:43.079] Timer tick, asking Buildbucket for the build status
[02:20:43.191] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:43.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:54:0) after 1m0s
[02:21:43.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:54:0)
[02:21:43.169] Timer tick, asking Buildbucket for the build status
[02:21:43.242] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:43.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:55:0) after 1m0s
[02:22:43.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:55:0)
[02:22:43.262] Timer tick, asking Buildbucket for the build status
[02:22:43.411] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:43.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:56:0) after 1m0s
[02:23:43.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:56:0)
[02:23:43.426] Timer tick, asking Buildbucket for the build status
[02:23:44.206] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:44.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:57:0) after 1m0s
[02:24:44.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:57:0)
[02:24:44.231] Timer tick, asking Buildbucket for the build status
[02:24:44.554] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:44.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:58:0) after 1m0s
[02:25:44.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:58:0)
[02:25:44.660] Timer tick, asking Buildbucket for the build status
[02:25:44.822] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:44.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:59:0) after 1m0s
[02:26:44.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:59:0)
[02:26:44.866] Timer tick, asking Buildbucket for the build status
[02:26:44.930] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:44.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:60:0) after 1m0s
[02:27:44.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:60:0)
[02:27:44.984] Timer tick, asking Buildbucket for the build status
[02:27:45.124] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:45.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:61:0) after 1m0s
[02:28:45.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:61:0)
[02:28:45.142] Timer tick, asking Buildbucket for the build status
[02:28:45.223] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:45.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:62:0) after 1m0s
[02:29:45.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:62:0)
[02:29:45.242] Timer tick, asking Buildbucket for the build status
[02:29:45.349] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:45.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:63:0) after 1m0s
[02:30:45.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:63:0)
[02:30:45.375] Timer tick, asking Buildbucket for the build status
[02:30:45.453] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:45.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:64:0) after 1m0s
[02:31:45.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:64:0)
[02:31:45.471] Timer tick, asking Buildbucket for the build status
[02:31:45.612] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:45.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:65:0) after 1m0s
[02:32:45.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:65:0)
[02:32:45.659] Timer tick, asking Buildbucket for the build status
[02:32:45.762] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:45.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:66:0) after 1m0s
[02:33:45.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:66:0)
[02:33:45.775] Timer tick, asking Buildbucket for the build status
[02:33:45.840] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:45.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:67:0) after 1m0s
[02:34:45.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:67:0)
[02:34:45.859] Timer tick, asking Buildbucket for the build status
[02:34:45.936] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:45.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:68:0) after 1m0s
[02:35:45.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:68:0)
[02:35:45.928] Timer tick, asking Buildbucket for the build status
[02:35:45.999] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:45.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:69:0) after 1m0s
[02:36:45.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:69:0)
[02:36:45.991] Timer tick, asking Buildbucket for the build status
[02:36:46.222] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:70:0) after 1m0s
[02:37:46.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:70:0)
[02:37:46.320] Timer tick, asking Buildbucket for the build status
[02:37:46.397] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:46.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:71:0) after 1m0s
[02:38:46.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:71:0)
[02:38:46.478] Timer tick, asking Buildbucket for the build status
[02:38:46.808] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:72:0) after 1m0s
[02:39:46.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:72:0)
[02:39:46.861] Timer tick, asking Buildbucket for the build status
[02:39:47.013] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:47.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:73:0) after 1m0s
[02:40:47.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:73:0)
[02:40:47.052] Timer tick, asking Buildbucket for the build status
[02:40:47.122] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:47.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:74:0) after 1m0s
[02:41:47.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:74:0)
[02:41:47.142] Timer tick, asking Buildbucket for the build status
[02:41:47.252] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:47.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:75:0) after 1m0s
[02:42:47.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:75:0)
[02:42:47.380] Timer tick, asking Buildbucket for the build status
[02:42:47.495] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:47.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:76:0) after 1m0s
[02:43:47.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:76:0)
[02:43:47.590] Timer tick, asking Buildbucket for the build status
[02:43:49.588] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:49.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:77:0) after 1m0s
[02:44:49.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:77:0)
[02:44:49.665] Timer tick, asking Buildbucket for the build status
[02:44:49.924] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:78:0) after 1m0s
[02:45:49.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:78:0)
[02:45:49.936] Timer tick, asking Buildbucket for the build status
[02:45:50.003] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:50.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:79:0) after 1m0s
[02:46:50.090] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:79:0)
[02:46:50.090] Timer tick, asking Buildbucket for the build status
[02:46:50.209] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:50.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:80:0) after 1m0s
[02:47:50.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:80:0)
[02:47:50.335] Timer tick, asking Buildbucket for the build status
[02:47:50.398] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:50.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:81:0) after 1m0s
[02:48:50.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:81:0)
[02:48:50.560] Timer tick, asking Buildbucket for the build status
[02:48:50.821] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:50.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:82:0) after 1m0s
[02:49:50.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:82:0)
[02:49:50.910] Timer tick, asking Buildbucket for the build status
[02:49:51.019] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:51.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:83:0) after 1m0s
[02:50:51.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:83:0)
[02:50:51.147] Timer tick, asking Buildbucket for the build status
[02:50:51.366] Build 8852553022735402032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:51.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9017983084677127680:84:0) after 1m0s
[02:50:59.967] Received PubSub notification, asking Buildbucket for the build status
[02:51:00.158] Build 8852553022735402032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:51:00.158] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615949459539259",
"created_by": "project:chromium",
"created_ts": "1615944569800890",
"id": "8852553022735402032",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\", \"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-31-mr04\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 26824, \"got_angle_revision\": \"27e12398b33894bf345dc8c496d0bcde527f9892\", \"got_dawn_revision\": \"cc84ee24fc89229d956a6cd1a8ed0f7fd7528c1b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\", \"got_revision_cp\": \"refs/heads/master@{#863584}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a0aeb64e01d75b257495eda180bea9758d072005\", \"got_v8_revision\": \"c47dfc8ab1b8c17a6959f42e069091a38e72c040\", \"got_v8_revision_cp\": \"refs/heads/9.1.140@{#1}\", \"got_webrtc_revision\": \"ab6335041130fdc0365a604f49668eac9194f9d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33479}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-viz-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e6dfc0ff54e8fc67dbef43947eb2c974a83344df\", \"swarm_hashes_refs/heads/master(at){#863584}_without_patch\": {\"blink_web_tests\": \"697dc765c5d5c2caa376a12980b66167a1d92739\", \"browser_tests\": \"625c3f18dbc2d0487deb1dbb846dbd64c2ee3998\", \"content_browsertests\": \"a4d2a7f029284476728b79b7120c16b292741b27\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5e40e9df3c25d6ec04b042625e64587de25b7cc9257c9b922c4342550ccccbb8_v2\", \"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_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-31-mr04\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615944683845001",
"status": "COMPLETED",
"status_changed_ts": "1615949459763048",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/26824",
"builder:Linux Viz",
"buildset:commit/git/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e6dfc0ff54e8fc67dbef43947eb2c974a83344df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017983084677127680",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852553022735402032/+/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:52569edfa0297e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615949459767530",
"url": "https://ci.chromium.org/b/8852553022735402032",
"utcnow_ts": "1615949460047036"
}
}
[02:51:00.158] Invocation finished in 1h21m31.593265252s with status SUCCEEDED