[02:02:28.997] New invocation is queued and will start shortly
[02:02:30.114] Starting the invocation (attempt 1)
[02:02:30.157] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:02:30.158] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:02:30.158] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028309062237511136",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b51db0e879589d9593ec18d1da51f7b0b712ef88\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028309062237511136",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"gitiles_ref:refs/heads/master"
]
}
[02:02:31.732] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1606096950793765",
"id": "8862878999683623216",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b51db0e879589d9593ec18d1da51f7b0b712ef88\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606096951578678",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43066",
"builder:linux-chromeos-rel",
"buildset:commit/git/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028309062237511136",
"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/8862878999683623216/+/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": "1606096951578821",
"url": "https://ci.chromium.org/b/8862878999683623216",
"utcnow_ts": "1606096951714934"
}
}
[02:02:31.732] Task URL: https://ci.chromium.org/b/8862878999683623216
[02:02:31.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:2:0) after 1m0s
[02:02:33.271] Received PubSub notification, asking Buildbucket for the build status
[02:02:33.488] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:2:0)
[02:03:31.802] Timer tick, asking Buildbucket for the build status
[02:03:31.942] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:4:0) after 1m0s
[02:04:32.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:4:0)
[02:04:32.022] Timer tick, asking Buildbucket for the build status
[02:04:32.088] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:32.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:5:0) after 1m0s
[02:05:32.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:5:0)
[02:05:32.135] Timer tick, asking Buildbucket for the build status
[02:05:32.265] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:32.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:6:0) after 1m0s
[02:06:32.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:6:0)
[02:06:32.287] Timer tick, asking Buildbucket for the build status
[02:06:32.393] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:32.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:7:0) after 1m0s
[02:07:32.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:7:0)
[02:07:32.415] Timer tick, asking Buildbucket for the build status
[02:07:32.507] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:8:0) after 1m0s
[02:08:33.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:8:0)
[02:08:33.432] Timer tick, asking Buildbucket for the build status
[02:08:33.554] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:33.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:9:0) after 1m0s
[02:09:33.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:9:0)
[02:09:33.573] Timer tick, asking Buildbucket for the build status
[02:09:33.640] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:33.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:10:0) after 1m0s
[02:10:33.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:10:0)
[02:10:33.752] Timer tick, asking Buildbucket for the build status
[02:10:33.821] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:11:0) after 1m0s
[02:11:33.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:11:0)
[02:11:33.986] Timer tick, asking Buildbucket for the build status
[02:11:34.067] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:12:0) after 1m0s
[02:12:34.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:12:0)
[02:12:34.151] Timer tick, asking Buildbucket for the build status
[02:12:34.249] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:34.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:13:0) after 1m0s
[02:13:34.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:13:0)
[02:13:34.302] Timer tick, asking Buildbucket for the build status
[02:13:34.358] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:34.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:14:0) after 1m0s
[02:14:34.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:14:0)
[02:14:34.414] Timer tick, asking Buildbucket for the build status
[02:14:34.529] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:15:0) after 1m0s
[02:15:34.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:15:0)
[02:15:34.562] Timer tick, asking Buildbucket for the build status
[02:15:34.633] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:16:0) after 1m0s
[02:16:34.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:16:0)
[02:16:34.735] Timer tick, asking Buildbucket for the build status
[02:16:34.791] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:17:0) after 1m0s
[02:17:34.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:17:0)
[02:17:34.899] Timer tick, asking Buildbucket for the build status
[02:17:35.008] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:35.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:18:0) after 1m0s
[02:18:35.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:18:0)
[02:18:35.104] Timer tick, asking Buildbucket for the build status
[02:18:35.256] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:35.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:19:0) after 1m0s
[02:19:35.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:19:0)
[02:19:35.302] Timer tick, asking Buildbucket for the build status
[02:19:35.368] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:20:0) after 1m0s
[02:20:35.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:20:0)
[02:20:35.397] Timer tick, asking Buildbucket for the build status
[02:20:35.455] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:21:0) after 1m0s
[02:21:35.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:21:0)
[02:21:35.495] Timer tick, asking Buildbucket for the build status
[02:21:35.550] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:22:0) after 1m0s
[02:22:35.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:22:0)
[02:22:35.634] Timer tick, asking Buildbucket for the build status
[02:22:35.745] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:23:0) after 1m0s
[02:23:35.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:23:0)
[02:23:35.782] Timer tick, asking Buildbucket for the build status
[02:23:35.839] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:35.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:24:0) after 1m0s
[02:24:35.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:24:0)
[02:24:35.876] Timer tick, asking Buildbucket for the build status
[02:24:35.931] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:35.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:25:0) after 1m0s
[02:25:36.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:25:0)
[02:25:36.052] Timer tick, asking Buildbucket for the build status
[02:25:36.111] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:26:0) after 1m0s
[02:26:36.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:26:0)
[02:26:36.118] Timer tick, asking Buildbucket for the build status
[02:26:36.234] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:36.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:27:0) after 1m0s
[02:27:36.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:27:0)
[02:27:36.287] Timer tick, asking Buildbucket for the build status
[02:27:36.401] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:36.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:28:0) after 1m0s
[02:28:36.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:28:0)
[02:28:36.505] Timer tick, asking Buildbucket for the build status
[02:28:36.565] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:36.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:29:0) after 1m0s
[02:29:36.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:29:0)
[02:29:36.642] Timer tick, asking Buildbucket for the build status
[02:29:36.705] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:36.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:30:0) after 1m0s
[02:30:36.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:30:0)
[02:30:36.774] Timer tick, asking Buildbucket for the build status
[02:30:36.843] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:36.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:31:0) after 1m0s
[02:31:36.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:31:0)
[02:31:36.867] Timer tick, asking Buildbucket for the build status
[02:31:37.109] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:32:0) after 1m0s
[02:32:37.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:32:0)
[02:32:37.117] Timer tick, asking Buildbucket for the build status
[02:32:37.302] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:37.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:33:0) after 1m0s
[02:33:37.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:33:0)
[02:33:37.359] Timer tick, asking Buildbucket for the build status
[02:33:37.508] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:37.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:34:0) after 1m0s
[02:34:37.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:34:0)
[02:34:37.584] Timer tick, asking Buildbucket for the build status
[02:34:37.811] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:37.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:35:0) after 1m0s
[02:35:37.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:35:0)
[02:35:37.836] Timer tick, asking Buildbucket for the build status
[02:35:37.888] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:37.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:36:0) after 1m0s
[02:36:37.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:36:0)
[02:36:37.916] Timer tick, asking Buildbucket for the build status
[02:36:37.977] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:37.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:37:0) after 1m0s
[02:37:38.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:37:0)
[02:37:38.005] Timer tick, asking Buildbucket for the build status
[02:37:38.123] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:38.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:38:0) after 1m0s
[02:38:38.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:38:0)
[02:38:38.144] Timer tick, asking Buildbucket for the build status
[02:38:38.248] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:38.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:39:0) after 1m0s
[02:39:38.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:39:0)
[02:39:38.310] Timer tick, asking Buildbucket for the build status
[02:39:38.730] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:38.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:40:0) after 1m0s
[02:40:38.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:40:0)
[02:40:38.759] Timer tick, asking Buildbucket for the build status
[02:40:39.318] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:39.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:41:0) after 1m0s
[02:41:39.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:41:0)
[02:41:39.349] Timer tick, asking Buildbucket for the build status
[02:41:39.483] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:39.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:42:0) after 1m0s
[02:42:39.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:42:0)
[02:42:39.561] Timer tick, asking Buildbucket for the build status
[02:42:39.693] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:39.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:43:0) after 1m0s
[02:43:39.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:43:0)
[02:43:39.748] Timer tick, asking Buildbucket for the build status
[02:43:39.859] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:39.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:44:0) after 1m0s
[02:44:39.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:44:0)
[02:44:39.883] Timer tick, asking Buildbucket for the build status
[02:44:39.979] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:39.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:45:0) after 1m0s
[02:45:40.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:45:0)
[02:45:40.009] Timer tick, asking Buildbucket for the build status
[02:45:40.412] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:40.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:46:0) after 1m0s
[02:46:40.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:46:0)
[02:46:40.459] Timer tick, asking Buildbucket for the build status
[02:46:40.585] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:40.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:47:0) after 1m0s
[02:47:40.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:47:0)
[02:47:40.675] Timer tick, asking Buildbucket for the build status
[02:47:40.790] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:40.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:48:0) after 1m0s
[02:48:40.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:48:0)
[02:48:40.852] Timer tick, asking Buildbucket for the build status
[02:48:40.964] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:40.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:49:0) after 1m0s
[02:49:41.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:49:0)
[02:49:41.092] Timer tick, asking Buildbucket for the build status
[02:49:41.196] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:41.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:50:0) after 1m0s
[02:50:41.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:50:0)
[02:50:41.244] Timer tick, asking Buildbucket for the build status
[02:50:41.337] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:41.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:51:0) after 1m0s
[02:51:41.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:51:0)
[02:51:41.406] Timer tick, asking Buildbucket for the build status
[02:51:41.796] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:41.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:52:0) after 1m0s
[02:52:41.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:52:0)
[02:52:41.825] Timer tick, asking Buildbucket for the build status
[02:52:41.949] Build 8862878999683623216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:41.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028309062237511136:53:0) after 1m0s
[02:53:29.847] Received PubSub notification, asking Buildbucket for the build status
[02:53:30.018] Build 8862878999683623216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:53:30.018] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1606100007755978",
"created_by": "project:chromium",
"created_ts": "1606096950793765",
"id": "8862878999683623216",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b51db0e879589d9593ec18d1da51f7b0b712ef88\"}}",
"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\": \"b51db0e879589d9593ec18d1da51f7b0b712ef88\", \"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-129-zr64\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43066, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"b51db0e879589d9593ec18d1da51f7b0b712ef88\", \"got_revision_cp\": \"refs/heads/master@{#830072}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"805e8b5987e5fd07adbe998f0c21f84cb20468b8\", \"got_v8_revision_cp\": \"refs/heads/8.9.32@{#1}\", \"got_webrtc_revision\": \"c5fd745672798221b71611a92c33ab5f2bf04a3b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32663}\", \"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\": \"b51db0e879589d9593ec18d1da51f7b0b712ef88\", \"swarm_hashes_refs/heads/master(at){#830072}_without_patch\": {\"absl_hardening_tests\": \"1275f5b9dc7d3b2cf668af4b1e5dd0b0802fd348\", \"accessibility_unittests\": \"49327800766d501393985b12d04d7923bacaa893\", \"angle_unittests\": \"3db6269bca9557533de33ba1bf85681db4e3f959\", \"app_list_unittests\": \"dda676491d7b1562a40b82957e00b61dc0e312ec\", \"app_shell_unittests\": \"200f51ce6e06bb8863d34ea59631ffa42e0d0275\", \"ash_unittests\": \"8b9ca1fb0affe3ead857778c991105a9cc6c7dc6\", \"aura_unittests\": \"7610bc138474df483a1d4098a1b480842559456a\", \"base_unittests\": \"0717324579b2d46e293d5c5fee32e0f9e0831ed9\", \"base_util_unittests\": \"0639181a0c5a7521769fed74dfecbcef59efc9dc\", \"blink_common_unittests\": \"2678d9f6bfcd736452c88129e9d36a268b6e4dd5\", \"blink_fuzzer_unittests\": \"cfdb9203804320e75ae883c9122890d120759c89\", \"blink_heap_unittests\": \"c4d4b5aa8956fb04ae1250538579e7bcc2eda732\", \"blink_platform_unittests\": \"820bc69302ffa509a9a8bc6e1724b0c417f4e591\", \"blink_unittests\": \"6aeb9c878c4f553721dda0ac84a0ad823468eb7d\", \"boringssl_crypto_tests\": \"8fd5161edf0c75d2bbef10080e86312301e4a7a3\", \"boringssl_ssl_tests\": \"4f47fed6a41556e792b7cc407473d2c34df24c09\", \"browser_tests\": \"e68de47a5b2e9662e784f3e1f2481d68581344d1\", \"capture_unittests\": \"91dba95b35c91d752d0627aca7451baa0d0c72e5\", \"cast_unittests\": \"19668a8ffb9308cab9bfb7ccdab5d7bc5f3c4be6\", \"cc_unittests\": \"214db31fdef3560f68c167a78a6ea2357650969d\", \"chrome_app_unittests\": \"bce888ac21dfc470649e2328e6ddcc46f6292f50\", \"chromedriver_unittests\": \"0e6bafd91776738e48717197fa4d49735775cd32\", \"chromeos_components_unittests\": \"6a5b59e3f94cf5cc0bc49becb2ab7100e7057a78\", \"chromeos_unittests\": \"9f1decc8bb0054025b1cda15bb9578138c6578c6\", \"components_browsertests\": \"16436b5c1a8a9506de031f19938c91dc9e5104e7\", \"components_unittests\": \"a7db0ea104e5982b574b1f12468303fc61a5db7c\", \"compositor_unittests\": \"7147bd2bb5d70b9824c8dcb79db637cbfe1af328\", \"content_browsertests\": \"a301db5149e9063b3faaff1b78d249c2f2b71949\", \"content_unittests\": \"bc8d83bf900cd805f1f61044078d7bde7bfc8577\", \"crashpad_tests\": \"a193d3c8fd977b59691811972fcfe8c75ab98331\", \"crypto_unittests\": \"ffbea861ff40ca63557bf9e0dbdece399f089f71\", \"dbus_unittests\": \"b30fda846fb981fced9fe364e0f5741785b30239\", \"device_unittests\": \"ec94ac6556887503845063a54f8abba496dfef58\", \"display_unittests\": \"f592acb9883a3a64c295578285e6919efdbff903\", \"events_unittests\": \"9381c4ca2aca4eb11faa795f5b7354894b4fd179\", \"exo_unittests\": \"1bf17d2105595c5bdf6e711311a7760ba7402fe7\", \"extensions_browsertests\": \"ddbb6f685296f16c54ea91effac25ab24c88e25a\", \"extensions_unittests\": \"4fb1ae3fd565447b07bd5fa5a04c1c8f4d2e77dd\", \"filesystem_service_unittests\": \"2f1f45f343fef805081edcedd48b5b574042e5e5\", \"gcm_unit_tests\": \"9478d4ab66729189c66f5dad4c828729b5d8cf2d\", \"gfx_unittests\": \"f8cb8793194b43ca92782032f46fb70f93fd06c3\", \"gin_unittests\": \"616eb73c094d76c5e1b1cd406a6c4a59bc9222c1\", \"gl_unittests_ozone\": \"2693b8b2d394dc3e92f687c9b769cfc9dc14279b\", \"google_apis_unittests\": \"3d46f3b6f82064ce8b2d5b4189e83daaca9edb7a\", \"gpu_unittests\": \"8e7e690a3773ae689da11c950f757337572ee2c0\", \"gwp_asan_unittests\": \"d65b1d2535acc5e12b11ac1f06edeaabbd0199d7\", \"interactive_ui_tests\": \"6c3904d97410ccb31cb4f6d4fe51517b40bf11e7\", \"ipc_tests\": \"7b805138acd41f306e0deb0f03372d607626c340\", \"jingle_unittests\": \"9bb00f4cf6b28097093916a0d49903ea0fe6131a\", \"keyboard_unittests\": \"94bd033f83458d66ad4280d96a2a4c75e28c9f2e\", \"latency_unittests\": \"ce9a2c9f8b8bd7008d55bb4eacbb31b71927ddf3\", \"libjingle_xmpp_unittests\": \"b5db31201688aef291126f97c63d9709e9f70629\", \"liburlpattern_unittests\": \"c4f95f31208321e19a0917611331c145f1753f84\", \"media_blink_unittests\": \"af57d0198a89ed5a7da0720400d2f195a393c15f\", \"media_unittests\": \"a2adeb97f620b2751d9a15cc4ae7f1f08d8b1778\", \"message_center_unittests\": \"e980dc95f10befacd67bb3d37d35126182584853\", \"midi_unittests\": \"75adc5694b22900af5ede6584d24a2f60ba48b43\", \"mojo_core_unittests\": \"e96594339dc2b1f7613fe2e58f2e213c5683ac70\", \"mojo_unittests\": \"f8b4ddd6db467a93dd3b591ef1ef769fb6e0e7d6\", \"nacl_helper_nonsfi_unittests\": \"0c529112e84422506f83264a7850ab1510f252a0\", \"nacl_loader_unittests\": \"b3b4d66c625adf9621d6c6560eefe6ee1b7cfd26\", \"native_theme_unittests\": \"7a554ffd03c7557f395f351a77862caf7d143532\", \"net_unittests\": \"b989c4c77c5fd639f4c1128097707862a4b11dd9\", \"ozone_gl_unittests\": \"cbabc31877c5de58e19a613357dcea1a0d6550bc\", \"ozone_unittests\": \"52660061af650da8a81db1da0d1625da8707038e\", \"ozone_x11_unittests\": \"4f42d47c071b9a34e7141c9662de63e469ddf536\", \"pdf_unittests\": \"3809564315b5de9931b0c0323141d8247016083d\", \"perfetto_unittests\": \"0e17c8f024261b8610ac61a4acb8aa0d6337da8f\", \"ppapi_unittests\": \"6ac35dd07ee86d644b272ca4c483b89b05ee063f\", \"printing_unittests\": \"d5c26e59062453eb9b7fa10f52f2b8eae84cca43\", \"remoting_unittests\": \"db7470985c706894ea010e653de318a123d432d6\", \"sandbox_linux_unittests\": \"e6f29da3918a2b546731c585ec11a6845e2751de\", \"service_manager_unittests\": \"51f430f3378bd40fd0ada00324e98c0fd11640da\", \"services_unittests\": \"6b8eb24d229a8e999a12c18e031f8d969af7944c\", \"shell_dialogs_unittests\": \"b5352b5fbae170eedcc991262c74486307271f42\", \"skia_unittests\": \"16dfa323524a783ee6d67b6bb824e1cd5e2337c9\", \"snapshot_unittests\": \"2b3a98e9678fa2134d36f1c16d80436436e64dd6\", \"sql_unittests\": \"8dcd0679665edbd2df178372b0cb764bfc7b6ed0\", \"storage_unittests\": \"352f83ebe56f48965167c8cbb20761e677628674\", \"sync_integration_tests\": \"a7666cdec42610dc9f558dbe0113cca1aebd34de\", \"traffic_annotation_auditor_unittests\": \"4a918482781668a7aa782e241b9d04bb9ac8658b\", \"ui_base_unittests\": \"55252a822bd114fea4adeecd2fd3dfb19f0b8eff\", \"ui_chromeos_unittests\": \"fcefddd92e905d5275c18dca42061259a4c53f3c\", \"ui_touch_selection_unittests\": \"303d9cd8e2b121438c4ceb8133ac4a807a8f79c5\", \"unit_tests\": \"5e293ebd6be782569b0da13a7ca836889d25c74e\", \"url_unittests\": \"5204538271f44926c4413caf9fc70b5e8a363e65\", \"usage_time_limit_unittests\": \"571aaaafee5ce095a92207d1888b092ada91200c\", \"views_unittests\": \"251440e097757e1187d2558f8a4716eec83b15cb\", \"viz_unittests\": \"f3606df42ad22a3f3b6001c36934928af904a906\", \"wayland_client_perftests\": \"94c4fa692fd37bf55b1bdee4e22e37f59d6c173b\", \"wm_unittests\": \"9bcd717614cd6cb30d0b02fa9fba7cee00e4af3c\", \"wtf_unittests\": \"d4ea2a6fef260eb835a188374f636a0fa5d2866b\", \"zlib_unittests\": \"012c3225ce92d10544c0d497e95c4b5ee6655e43\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-129-zr64\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606096952527056",
"status": "COMPLETED",
"status_changed_ts": "1606100008199022",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43066",
"builder:linux-chromeos-rel",
"buildset:commit/git/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b51db0e879589d9593ec18d1da51f7b0b712ef88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028309062237511136",
"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/8862878999683623216/+/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:500ba821f7b56410",
"user_agent:luci-scheduler"
],
"updated_ts": "1606100008207603",
"url": "https://ci.chromium.org/b/8862878999683623216",
"utcnow_ts": "1606100010000430"
}
}
[02:53:30.018] Invocation finished in 51m1.044495078s with status SUCCEEDED