[08:10:12.208] New invocation is queued and will start shortly
[08:10:16.024] Starting the invocation (attempt 1)
[08:10:16.068] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:10:16.068] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:10:16.069] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029463687844936656",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029463687844936656",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"gitiles_ref:refs/heads/master"
]
}
[08:10:17.286] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604995816168575",
"id": "8864033623023789392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604995816847259",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42742",
"builder:linux-chromeos-rel",
"buildset:commit/git/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029463687844936656",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864033623023789392/+/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": "1604995816847368",
"url": "https://ci.chromium.org/b/8864033623023789392",
"utcnow_ts": "1604995817274308"
}
}
[08:10:17.286] Task URL: https://ci.chromium.org/b/8864033623023789392
[08:10:17.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:2:0) after 1m0s
[08:10:20.254] Received PubSub notification, asking Buildbucket for the build status
[08:10:20.402] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:17.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:2:0)
[08:11:17.291] Timer tick, asking Buildbucket for the build status
[08:11:17.438] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:17.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:4:0) after 1m0s
[08:12:17.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:4:0)
[08:12:17.508] Timer tick, asking Buildbucket for the build status
[08:12:17.861] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:5:0) after 1m0s
[08:13:17.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:5:0)
[08:13:17.876] Timer tick, asking Buildbucket for the build status
[08:13:17.991] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:17.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:6:0) after 1m0s
[08:14:18.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:6:0)
[08:14:18.262] Timer tick, asking Buildbucket for the build status
[08:14:18.577] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:18.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:7:0) after 1m0s
[08:15:18.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:7:0)
[08:15:18.692] Timer tick, asking Buildbucket for the build status
[08:15:18.855] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:18.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:8:0) after 1m0s
[08:16:18.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:8:0)
[08:16:18.936] Timer tick, asking Buildbucket for the build status
[08:16:19.042] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:9:0) after 1m0s
[08:17:19.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:9:0)
[08:17:19.086] Timer tick, asking Buildbucket for the build status
[08:17:19.147] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:19.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:10:0) after 1m0s
[08:18:19.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:10:0)
[08:18:19.214] Timer tick, asking Buildbucket for the build status
[08:18:19.303] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:19.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:11:0) after 1m0s
[08:19:19.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:11:0)
[08:19:19.458] Timer tick, asking Buildbucket for the build status
[08:19:20.281] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:20.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:12:0) after 1m0s
[08:20:20.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:12:0)
[08:20:20.822] Timer tick, asking Buildbucket for the build status
[08:20:20.947] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:20.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:13:0) after 1m0s
[08:21:21.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:13:0)
[08:21:21.266] Timer tick, asking Buildbucket for the build status
[08:21:21.335] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:21.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:14:0) after 1m0s
[08:22:21.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:14:0)
[08:22:21.595] Timer tick, asking Buildbucket for the build status
[08:22:21.744] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:21.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:15:0) after 1m0s
[08:23:21.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:15:0)
[08:23:21.796] Timer tick, asking Buildbucket for the build status
[08:23:21.894] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:21.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:16:0) after 1m0s
[08:24:22.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:16:0)
[08:24:22.136] Timer tick, asking Buildbucket for the build status
[08:24:22.544] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:17:0) after 1m0s
[08:25:22.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:17:0)
[08:25:22.526] Timer tick, asking Buildbucket for the build status
[08:25:23.368] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:23.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:18:0) after 1m0s
[08:26:23.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:18:0)
[08:26:23.430] Timer tick, asking Buildbucket for the build status
[08:26:23.501] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:23.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:19:0) after 1m0s
[08:27:23.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:19:0)
[08:27:23.486] Timer tick, asking Buildbucket for the build status
[08:27:23.563] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:23.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:20:0) after 1m0s
[08:28:23.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:20:0)
[08:28:23.601] Timer tick, asking Buildbucket for the build status
[08:28:23.717] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:23.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:21:0) after 1m0s
[08:29:23.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:21:0)
[08:29:23.765] Timer tick, asking Buildbucket for the build status
[08:29:23.825] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:23.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:22:0) after 1m0s
[08:30:23.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:22:0)
[08:30:23.876] Timer tick, asking Buildbucket for the build status
[08:30:24.273] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:24.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:23:0) after 1m0s
[08:31:24.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:23:0)
[08:31:24.337] Timer tick, asking Buildbucket for the build status
[08:31:24.494] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:24.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:24:0) after 1m0s
[08:32:24.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:24:0)
[08:32:24.557] Timer tick, asking Buildbucket for the build status
[08:32:24.685] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:24.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:25:0) after 1m0s
[08:33:24.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:25:0)
[08:33:24.760] Timer tick, asking Buildbucket for the build status
[08:33:24.820] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:24.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:26:0) after 1m0s
[08:34:24.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:26:0)
[08:34:24.877] Timer tick, asking Buildbucket for the build status
[08:34:24.942] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:24.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:27:0) after 1m0s
[08:35:24.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:27:0)
[08:35:24.969] Timer tick, asking Buildbucket for the build status
[08:35:25.130] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:25.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:28:0) after 1m0s
[08:36:25.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:28:0)
[08:36:25.156] Timer tick, asking Buildbucket for the build status
[08:36:25.330] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:25.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:29:0) after 1m0s
[08:37:25.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:29:0)
[08:37:25.416] Timer tick, asking Buildbucket for the build status
[08:37:25.518] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:25.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:30:0) after 1m0s
[08:38:25.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:30:0)
[08:38:25.551] Timer tick, asking Buildbucket for the build status
[08:38:25.680] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:25.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:31:0) after 1m0s
[08:39:25.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:31:0)
[08:39:25.707] Timer tick, asking Buildbucket for the build status
[08:39:25.833] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:25.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:32:0) after 1m0s
[08:40:25.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:32:0)
[08:40:25.862] Timer tick, asking Buildbucket for the build status
[08:40:25.973] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:33:0) after 1m0s
[08:41:26.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:33:0)
[08:41:26.011] Timer tick, asking Buildbucket for the build status
[08:41:26.297] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:26.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:34:0) after 1m0s
[08:42:26.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:34:0)
[08:42:26.328] Timer tick, asking Buildbucket for the build status
[08:42:26.404] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:26.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:35:0) after 1m0s
[08:43:26.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:35:0)
[08:43:26.580] Timer tick, asking Buildbucket for the build status
[08:43:26.673] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:26.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:36:0) after 1m0s
[08:44:26.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:36:0)
[08:44:26.711] Timer tick, asking Buildbucket for the build status
[08:44:26.853] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:26.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:37:0) after 1m0s
[08:45:26.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:37:0)
[08:45:26.882] Timer tick, asking Buildbucket for the build status
[08:45:27.317] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:27.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:38:0) after 1m0s
[08:46:27.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:38:0)
[08:46:27.367] Timer tick, asking Buildbucket for the build status
[08:46:27.438] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:27.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:39:0) after 1m0s
[08:47:27.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:39:0)
[08:47:27.552] Timer tick, asking Buildbucket for the build status
[08:47:27.629] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:27.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:40:0) after 1m0s
[08:48:27.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:40:0)
[08:48:27.661] Timer tick, asking Buildbucket for the build status
[08:48:27.724] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:27.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:41:0) after 1m0s
[08:49:27.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:41:0)
[08:49:27.735] Timer tick, asking Buildbucket for the build status
[08:49:27.796] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:42:0) after 1m0s
[08:50:27.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:42:0)
[08:50:27.818] Timer tick, asking Buildbucket for the build status
[08:50:27.967] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:27.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:43:0) after 1m0s
[08:51:27.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:43:0)
[08:51:27.996] Timer tick, asking Buildbucket for the build status
[08:51:28.123] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:28.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:44:0) after 1m0s
[08:52:28.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:44:0)
[08:52:28.145] Timer tick, asking Buildbucket for the build status
[08:52:28.252] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:28.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:45:0) after 1m0s
[08:53:28.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:45:0)
[08:53:28.419] Timer tick, asking Buildbucket for the build status
[08:53:28.520] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:28.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:46:0) after 1m0s
[08:54:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:46:0)
[08:54:28.699] Timer tick, asking Buildbucket for the build status
[08:54:28.795] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:28.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:47:0) after 1m0s
[08:55:28.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:47:0)
[08:55:28.799] Timer tick, asking Buildbucket for the build status
[08:55:28.916] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:28.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:48:0) after 1m0s
[08:56:29.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:48:0)
[08:56:29.061] Timer tick, asking Buildbucket for the build status
[08:56:30.067] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:30.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:49:0) after 1m0s
[08:57:30.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:49:0)
[08:57:30.350] Timer tick, asking Buildbucket for the build status
[08:57:30.522] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:30.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:50:0) after 1m0s
[08:58:30.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:50:0)
[08:58:30.620] Timer tick, asking Buildbucket for the build status
[08:58:30.734] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:30.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:51:0) after 1m0s
[08:59:30.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:51:0)
[08:59:30.876] Timer tick, asking Buildbucket for the build status
[08:59:30.992] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:30.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:52:0) after 1m0s
[09:00:31.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:52:0)
[09:00:31.252] Timer tick, asking Buildbucket for the build status
[09:00:31.409] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:31.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:53:0) after 1m0s
[09:01:31.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:53:0)
[09:01:31.535] Timer tick, asking Buildbucket for the build status
[09:01:32.094] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:32.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:54:0) after 1m0s
[09:02:32.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:54:0)
[09:02:32.821] Timer tick, asking Buildbucket for the build status
[09:02:32.975] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:32.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:55:0) after 1m0s
[09:03:33.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:55:0)
[09:03:33.190] Timer tick, asking Buildbucket for the build status
[09:03:33.325] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:33.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:56:0) after 1m0s
[09:04:33.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:56:0)
[09:04:33.516] Timer tick, asking Buildbucket for the build status
[09:04:33.642] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:33.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:57:0) after 1m0s
[09:05:33.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:57:0)
[09:05:33.750] Timer tick, asking Buildbucket for the build status
[09:05:33.866] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:33.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:58:0) after 1m0s
[09:06:34.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:58:0)
[09:06:34.014] Timer tick, asking Buildbucket for the build status
[09:06:34.793] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:34.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:59:0) after 1m0s
[09:07:34.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:59:0)
[09:07:34.940] Timer tick, asking Buildbucket for the build status
[09:07:35.105] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:35.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:60:0) after 1m0s
[09:08:35.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:60:0)
[09:08:35.212] Timer tick, asking Buildbucket for the build status
[09:08:35.387] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:35.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:61:0) after 1m0s
[09:09:35.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:61:0)
[09:09:35.527] Timer tick, asking Buildbucket for the build status
[09:09:35.781] Build 8864033623023789392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:35.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029463687844936656:62:0) after 1m0s
[09:09:52.922] Received PubSub notification, asking Buildbucket for the build status
[09:09:53.173] Build 8864033623023789392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:09:53.173] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604999390885556",
"created_by": "project:chromium",
"created_ts": "1604995816168575",
"id": "8864033623023789392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\"}}",
"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\": \"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\", \"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-central1-b-8-203-uj3r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42742, \"got_angle_revision\": \"36787dcb438203b3bade1d99aa5b996c84d04cbe\", \"got_dawn_revision\": \"c04a0132be6c384c90bd33b06929a9b7fc5d4726\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\", \"got_revision_cp\": \"refs/heads/master@{#825721}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4f7c1ce4e19200addcecfabd0ee84982d4316477\", \"got_v8_revision_cp\": \"refs/heads/8.8.271@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d9d4f26fd438d30a998b5117dcfdacad1086e8c\", \"swarm_hashes_refs/heads/master(at){#825721}_without_patch\": {\"absl_hardening_tests\": \"2d832d4939bab3d926c1b06ddfe35b527c598a25\", \"accessibility_unittests\": \"d7f2a23f0f2e858e5a662598a7e4fed62b1cfcaa\", \"angle_unittests\": \"7682a2d388fa96c49a46c8ebbbad775697c72a38\", \"app_list_unittests\": \"20ec9345d19f1e8fe0decfa6219da71ad9b6d276\", \"app_shell_unittests\": \"f2be7cbf4039e49233f35640a3a1e295fa839225\", \"ash_unittests\": \"63286fe15d7da038e86bb591374843a53b02cdbb\", \"aura_unittests\": \"a20806d63a7e3277565fdbc3e4c02bad9192e2dd\", \"base_unittests\": \"4f0e50488bac1874fbd197413e584809a2dedb31\", \"base_util_unittests\": \"2b50450779aa929cfc906bb9cda78122a9a97f25\", \"blink_common_unittests\": \"603e59ca24b168052a97930c087ca59e4a48eeff\", \"blink_fuzzer_unittests\": \"07a8aa2149dbf29ec670160f611874f410da0ee2\", \"blink_heap_unittests\": \"68ccec9f5b6c3372140e70eb9de7332d1e7b35d1\", \"blink_platform_unittests\": \"bbda99ff0f5cbff73feaafaf86464d426da22c3b\", \"blink_unittests\": \"e722688b57348840cd1e3fa39fe70b1c7a00e6a2\", \"boringssl_crypto_tests\": \"7349745cc67c9785753caa631d4bda75fbc42f00\", \"boringssl_ssl_tests\": \"07cdee842c5c4b0b3013c512b3216b685ae479a3\", \"browser_tests\": \"d52a676c1b58b247b08d4ca3ce62b65f40f6b687\", \"capture_unittests\": \"9a888993c795915832d4332e331583e6a5684cdd\", \"cast_unittests\": \"aa88a72fc8ab15ff95fa9a8ab592853115153555\", \"cc_unittests\": \"83ea5c2e5c95e6636c6ea9b70f0625c1829138fe\", \"chrome_app_unittests\": \"29cfcca50b1b7b76b4cf412defc9d5ba54dd0303\", \"chromedriver_unittests\": \"650e382358e4d9d63f889fc2f88800d9cc4c6f8e\", \"chromeos_components_unittests\": \"55c83065858c6218e2fcdf30f1dc39dd880d7ad2\", \"chromeos_unittests\": \"74f7e8a324e8647015f482be3091ff9f71d8c9e0\", \"components_browsertests\": \"ade5573bb7d45ce456f84a131d1ea40e6993622c\", \"components_unittests\": \"c8baf2fb279a2566dcdbc4cacd85694a04d49502\", \"compositor_unittests\": \"05d818e8b8c81d8bf3659ccc65bda4d238f828fb\", \"content_browsertests\": \"288bcfa0398b24477f348b3ce94a462db36e303e\", \"content_unittests\": \"61d20ac04537fcc79638b7520fa402298c7673ab\", \"crypto_unittests\": \"d01ad0eb3fbd7de6225b1737b1d4cf95dccb92c1\", \"dbus_unittests\": \"40e9d9ebe956028e706e2b3f5a3d5b3e37d02b60\", \"device_unittests\": \"75350d1759f8dd4d1225dd7f3d48a3160c19a9db\", \"display_unittests\": \"ada7e60cd14e20bb4fb10380715a54ec7013fd83\", \"events_unittests\": \"b109ef23d8998ce119ea6c985584ec52f2ca38d7\", \"exo_unittests\": \"14cb10f584df1b50fbf500c0c56fffbb8c7e16b2\", \"extensions_browsertests\": \"086ef428ac21275366df572d7ac305e842d038dd\", \"extensions_unittests\": \"4ca60e75fc469085c18c4592abbc68a69537a40d\", \"filesystem_service_unittests\": \"511a8398e460b1b39beb62abf645a7589c61aec2\", \"gcm_unit_tests\": \"76d8eec7bb6afbde559136469554e350f63a42de\", \"gfx_unittests\": \"42365d5e5d563317613c4c236944b13b0b2a0d10\", \"gin_unittests\": \"f707fc9419f3998ecf41b2acdf9fba987a4e794e\", \"gl_unittests_ozone\": \"7f6648a21e4cc6249916c52294de66c85609ff31\", \"google_apis_unittests\": \"23a76b345066f40fd6b7eaac20018c08c15efaf8\", \"gpu_unittests\": \"f3cd93fef5bd1f07fc8326ed3f20651bd2ad145f\", \"gwp_asan_unittests\": \"50a9bc821f47fe5df5cf8b3f4c7c5ee464e12086\", \"interactive_ui_tests\": \"80f7cfe67a2ae019df8da3c81358b75b39dc19c1\", \"ipc_tests\": \"364e6e1b4c3a9fd0c0e62c2cf6392d78f07fb003\", \"jingle_unittests\": \"df912e98bc66919bf8f8b3c7499aad790edc6805\", \"keyboard_unittests\": \"d6dd7073ab91997da169dbb1059c2d32bb07a69e\", \"latency_unittests\": \"520906e46e3d0b80426309f2e8dbbc7b84164c6c\", \"libjingle_xmpp_unittests\": \"dafdb6896a0728b5b33eddfeab102568e22f2f06\", \"liburlpattern_unittests\": \"ac048f8c80c42ca9d6fbad38723fdb2360175c18\", \"media_blink_unittests\": \"f6f5c7df878b9fb272a9757922e8ea795fff9cb0\", \"media_unittests\": \"603ec3ddfc87dd5dd9661f3b3c549dc549886983\", \"message_center_unittests\": \"5dba8d7f8420e85b01b313850780dfbdfa2e76b6\", \"midi_unittests\": \"db8ca3b34be45cd2c367a4f2a9bb7bdab0c2b261\", \"mojo_core_unittests\": \"b19a3698ac69456e6102ef16daca7a50e6e0488f\", \"mojo_unittests\": \"71bfadf99e17df072fc31f9cd93e3da1c3d6e5da\", \"nacl_helper_nonsfi_unittests\": \"c409ff95f9188f87242ae396a02968e36b9e0960\", \"nacl_loader_unittests\": \"746ed7b6bec776cec05412900f2b7ee632fdd5ef\", \"native_theme_unittests\": \"e3bb22f8cc80d68382f7264596d90efcc376a824\", \"net_unittests\": \"82f85a52f86e0af3461c742b3d099c4dc46363f7\", \"ozone_gl_unittests\": \"c274199492a8bcfcc2981fdebeaba327c2149ea6\", \"ozone_unittests\": \"764d84f4f5d38634b5e029fb948a32c291fca0ee\", \"ozone_x11_unittests\": \"1bdb4b54e9a643688fbfbaf221ca4b900e19b94f\", \"pdf_unittests\": \"faef706430554fb9dd452c795182db9c793462ea\", \"perfetto_unittests\": \"16cdb277c626d64e600a78cbe013966882c02ed9\", \"ppapi_unittests\": \"95fe68829d3fc99fa0bbc51ba1c33b1a68c8b799\", \"printing_unittests\": \"626803c64ce3019433b04c3940649c9a99783a5a\", \"remoting_unittests\": \"b2950b85bc1afaa95ab9c10c2cbc1bd526a32ac1\", \"sandbox_linux_unittests\": \"ef0f12f8263afc6a249963887d6e465dac80b725\", \"service_manager_unittests\": \"bd04743fe2619ebb94cec892f33def46c957c10e\", \"services_unittests\": \"5a435d3fadaa8637c006262d8184f3d901ece518\", \"shell_dialogs_unittests\": \"5a32f19652e9867edd4c35c3f3462e454bbb7c2d\", \"skia_unittests\": \"dd86e3c64cda47d0c41e5fe022b75a04dbd981a7\", \"snapshot_unittests\": \"cf360df8a2ec9da8059dd9c416cdb2249c57b2ec\", \"sql_unittests\": \"3bcc959d565701ced1d7a0b3d7e2be7b1f7bde9c\", \"storage_unittests\": \"5fab3e2e6c7a5816a098ff825f2535fb87417bca\", \"sync_integration_tests\": \"4427c9d8cce5311b8f4edb18003f691ecd4203bb\", \"traffic_annotation_auditor_unittests\": \"4f104f4d5945040e196d60851368601b464a66dc\", \"ui_base_unittests\": \"0fa12dd3ae3e84b5212251d7057684dd26203943\", \"ui_chromeos_unittests\": \"dd1c8aa026355b4ed5d273ade4b0e5952369055e\", \"ui_touch_selection_unittests\": \"de08b7fb4a5466248d509c488c3a2d307629d766\", \"unit_tests\": \"f77b3f8e960fc637e6533fd363ab59b1085f6ab6\", \"url_unittests\": \"d7cbf1002a73045ad7b6d43c63c643b33dacf4a8\", \"usage_time_limit_unittests\": \"5a8ed09db10b31f9b0fad167a71d93b85b3c971d\", \"views_unittests\": \"ec54bd1366a32f8467728419c12d26bf448424b9\", \"viz_unittests\": \"fbad65a2e059b7fe7ee032cdaa9e99f3a5e84da5\", \"wayland_client_perftests\": \"d6ac9414ab5b259565e8820aee37854223031d54\", \"wm_unittests\": \"7e73695e8bf9b5bde2174784c23d3e19dc0d70af\", \"wtf_unittests\": \"9cb682f4a256621c342e25759669938957305677\", \"zlib_unittests\": \"922bc4e1f5453573cf5ec0b6514275086de6e42e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0eb0a6f6f49375c133e7af8048caaf1812a31b1811f4b52b8753fe729d0821de_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_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-central1-b-8-203-uj3r\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604995819298623",
"status": "COMPLETED",
"status_changed_ts": "1604999391372134",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42742",
"builder:linux-chromeos-rel",
"buildset:commit/git/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d9d4f26fd438d30a998b5117dcfdacad1086e8c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029463687844936656",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864033623023789392/+/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:4fca06275d218010",
"user_agent:luci-scheduler"
],
"updated_ts": "1604999391383220",
"url": "https://ci.chromium.org/b/8864033623023789392",
"utcnow_ts": "1604999393159899"
}
}
[09:09:53.173] Invocation finished in 59m40.985704258s with status SUCCEEDED