[06:40:14.195] New invocation is queued and will start shortly
[06:40:15.442] Starting the invocation (attempt 1)
[06:40:15.474] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:40:15.474] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:40:15.474] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017963533333448176",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9017963533333448176",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"gitiles_ref:refs/heads/master"
]
}
[06:40:16.034] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615963215548649",
"id": "8852533471251969088",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615963215922524",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181444",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017963533333448176",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852533471251969088/+/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": "1615963215922714",
"url": "https://ci.chromium.org/b/8852533471251969088",
"utcnow_ts": "1615963216028168"
}
}
[06:40:16.034] Task URL: https://ci.chromium.org/b/8852533471251969088
[06:40:16.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:2:0) after 1m0s
[06:40:53.884] Received PubSub notification, asking Buildbucket for the build status
[06:40:54.103] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:16.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:2:0)
[06:41:16.262] Timer tick, asking Buildbucket for the build status
[06:41:16.329] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:16.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:4:0) after 1m0s
[06:42:16.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:4:0)
[06:42:16.423] Timer tick, asking Buildbucket for the build status
[06:42:16.715] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:16.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:5:0) after 1m0s
[06:43:16.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:5:0)
[06:43:16.781] Timer tick, asking Buildbucket for the build status
[06:43:16.894] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:16.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:6:0) after 1m0s
[06:44:17.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:6:0)
[06:44:17.002] Timer tick, asking Buildbucket for the build status
[06:44:17.066] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:7:0) after 1m0s
[06:45:17.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:7:0)
[06:45:17.132] Timer tick, asking Buildbucket for the build status
[06:45:17.216] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:17.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:8:0) after 1m0s
[06:46:17.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:8:0)
[06:46:17.237] Timer tick, asking Buildbucket for the build status
[06:46:17.323] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:17.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:9:0) after 1m0s
[06:47:17.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:9:0)
[06:47:17.447] Timer tick, asking Buildbucket for the build status
[06:47:17.713] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:17.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:10:0) after 1m0s
[06:48:17.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:10:0)
[06:48:17.747] Timer tick, asking Buildbucket for the build status
[06:48:18.067] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:18.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:11:0) after 1m0s
[06:49:18.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:11:0)
[06:49:18.128] Timer tick, asking Buildbucket for the build status
[06:49:18.458] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:18.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:12:0) after 1m0s
[06:50:18.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:12:0)
[06:50:18.509] Timer tick, asking Buildbucket for the build status
[06:50:18.577] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:18.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:13:0) after 1m0s
[06:51:18.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:13:0)
[06:51:18.652] Timer tick, asking Buildbucket for the build status
[06:51:18.717] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:14:0) after 1m0s
[06:52:18.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:14:0)
[06:52:18.745] Timer tick, asking Buildbucket for the build status
[06:52:18.854] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:18.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:15:0) after 1m0s
[06:53:18.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:15:0)
[06:53:18.941] Timer tick, asking Buildbucket for the build status
[06:53:19.179] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:19.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:16:0) after 1m0s
[06:54:19.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:16:0)
[06:54:19.278] Timer tick, asking Buildbucket for the build status
[06:54:19.402] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:19.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:17:0) after 1m0s
[06:55:19.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:17:0)
[06:55:19.511] Timer tick, asking Buildbucket for the build status
[06:55:19.594] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:19.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:18:0) after 1m0s
[06:56:19.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:18:0)
[06:56:19.613] Timer tick, asking Buildbucket for the build status
[06:56:19.679] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:19.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:19:0) after 1m0s
[06:57:19.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:19:0)
[06:57:19.702] Timer tick, asking Buildbucket for the build status
[06:57:19.875] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:19.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:20:0) after 1m0s
[06:58:19.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:20:0)
[06:58:19.852] Timer tick, asking Buildbucket for the build status
[06:58:20.096] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:20.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:21:0) after 1m0s
[06:59:20.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:21:0)
[06:59:20.164] Timer tick, asking Buildbucket for the build status
[06:59:20.309] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:20.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:22:0) after 1m0s
[07:00:20.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:22:0)
[07:00:20.380] Timer tick, asking Buildbucket for the build status
[07:00:20.603] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:23:0) after 1m0s
[07:01:20.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:23:0)
[07:01:20.734] Timer tick, asking Buildbucket for the build status
[07:01:20.987] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:20.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:24:0) after 1m0s
[07:02:21.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:24:0)
[07:02:21.003] Timer tick, asking Buildbucket for the build status
[07:02:21.156] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:21.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:25:0) after 1m0s
[07:03:21.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:25:0)
[07:03:21.208] Timer tick, asking Buildbucket for the build status
[07:03:21.317] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:21.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:26:0) after 1m0s
[07:04:21.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:26:0)
[07:04:21.450] Timer tick, asking Buildbucket for the build status
[07:04:21.645] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:21.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:27:0) after 1m0s
[07:05:21.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:27:0)
[07:05:21.775] Timer tick, asking Buildbucket for the build status
[07:05:21.852] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:21.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:28:0) after 1m0s
[07:06:21.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:28:0)
[07:06:21.922] Timer tick, asking Buildbucket for the build status
[07:06:22.007] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:22.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:29:0) after 1m0s
[07:07:21.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:29:0)
[07:07:21.991] Timer tick, asking Buildbucket for the build status
[07:07:22.060] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:22.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:30:0) after 1m0s
[07:08:22.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:30:0)
[07:08:22.091] Timer tick, asking Buildbucket for the build status
[07:08:22.274] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:22.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:31:0) after 1m0s
[07:09:22.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:31:0)
[07:09:22.343] Timer tick, asking Buildbucket for the build status
[07:09:22.412] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:22.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:32:0) after 1m0s
[07:10:22.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:32:0)
[07:10:22.434] Timer tick, asking Buildbucket for the build status
[07:10:22.614] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:22.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:33:0) after 1m0s
[07:11:22.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:33:0)
[07:11:22.659] Timer tick, asking Buildbucket for the build status
[07:11:22.727] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:22.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:34:0) after 1m0s
[07:12:22.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:34:0)
[07:12:22.705] Timer tick, asking Buildbucket for the build status
[07:12:22.866] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:22.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:35:0) after 1m0s
[07:13:22.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:35:0)
[07:13:22.874] Timer tick, asking Buildbucket for the build status
[07:13:22.933] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:22.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:36:0) after 1m0s
[07:14:22.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:36:0)
[07:14:22.939] Timer tick, asking Buildbucket for the build status
[07:14:23.018] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:23.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:37:0) after 1m0s
[07:15:23.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:37:0)
[07:15:23.084] Timer tick, asking Buildbucket for the build status
[07:15:23.164] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:23.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:38:0) after 1m0s
[07:16:23.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:38:0)
[07:16:23.242] Timer tick, asking Buildbucket for the build status
[07:16:23.311] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:39:0) after 1m0s
[07:17:23.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:39:0)
[07:17:23.306] Timer tick, asking Buildbucket for the build status
[07:17:23.642] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:23.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:40:0) after 1m0s
[07:18:23.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:40:0)
[07:18:23.677] Timer tick, asking Buildbucket for the build status
[07:18:23.751] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:41:0) after 1m0s
[07:19:23.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:41:0)
[07:19:23.864] Timer tick, asking Buildbucket for the build status
[07:19:24.201] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:24.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:42:0) after 1m0s
[07:20:24.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:42:0)
[07:20:24.243] Timer tick, asking Buildbucket for the build status
[07:20:24.341] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:24.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:43:0) after 1m0s
[07:21:24.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:43:0)
[07:21:24.405] Timer tick, asking Buildbucket for the build status
[07:21:24.478] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:24.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:44:0) after 1m0s
[07:22:24.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:44:0)
[07:22:24.609] Timer tick, asking Buildbucket for the build status
[07:22:24.678] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:24.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:45:0) after 1m0s
[07:23:24.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:45:0)
[07:23:24.711] Timer tick, asking Buildbucket for the build status
[07:23:24.848] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:24.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:46:0) after 1m0s
[07:24:24.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:46:0)
[07:24:24.881] Timer tick, asking Buildbucket for the build status
[07:24:24.951] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:24.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:47:0) after 1m0s
[07:25:25.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:47:0)
[07:25:25.008] Timer tick, asking Buildbucket for the build status
[07:25:25.072] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:25.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:48:0) after 1m0s
[07:26:25.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:48:0)
[07:26:25.223] Timer tick, asking Buildbucket for the build status
[07:26:25.295] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:25.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:49:0) after 1m0s
[07:27:25.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:49:0)
[07:27:25.373] Timer tick, asking Buildbucket for the build status
[07:27:25.489] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:25.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:50:0) after 1m0s
[07:28:25.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:50:0)
[07:28:25.507] Timer tick, asking Buildbucket for the build status
[07:28:25.674] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:25.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:51:0) after 1m0s
[07:29:25.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:51:0)
[07:29:25.749] Timer tick, asking Buildbucket for the build status
[07:29:25.823] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:25.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:52:0) after 1m0s
[07:30:25.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:52:0)
[07:30:25.885] Timer tick, asking Buildbucket for the build status
[07:30:26.050] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:53:0) after 1m0s
[07:31:26.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:53:0)
[07:31:26.067] Timer tick, asking Buildbucket for the build status
[07:31:26.416] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:26.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:54:0) after 1m0s
[07:32:26.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:54:0)
[07:32:26.510] Timer tick, asking Buildbucket for the build status
[07:32:26.871] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:26.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:55:0) after 1m0s
[07:33:26.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:55:0)
[07:33:26.920] Timer tick, asking Buildbucket for the build status
[07:33:27.008] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:27.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:56:0) after 1m0s
[07:34:27.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:56:0)
[07:34:27.024] Timer tick, asking Buildbucket for the build status
[07:34:27.200] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:57:0) after 1m0s
[07:35:27.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:57:0)
[07:35:27.209] Timer tick, asking Buildbucket for the build status
[07:35:27.293] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:27.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:58:0) after 1m0s
[07:36:27.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:58:0)
[07:36:27.267] Timer tick, asking Buildbucket for the build status
[07:36:27.364] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:27.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:59:0) after 1m0s
[07:37:27.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:59:0)
[07:37:27.340] Timer tick, asking Buildbucket for the build status
[07:37:27.577] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:27.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:60:0) after 1m0s
[07:38:27.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:60:0)
[07:38:27.596] Timer tick, asking Buildbucket for the build status
[07:38:27.857] Build 8852533471251969088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:27.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017963533333448176:61:0) after 1m0s
[07:38:32.081] Received PubSub notification, asking Buildbucket for the build status
[07:38:32.155] Build 8852533471251969088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:38:32.155] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615966709973052",
"created_by": "project:chromium",
"created_ts": "1615963215548649",
"id": "8852533471251969088",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\", \"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-105-er0e\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181444, \"got_angle_revision\": \"27e12398b33894bf345dc8c496d0bcde527f9892\", \"got_dawn_revision\": \"ed16517e32ce29c64abc05b19c0ea31671c8b053\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\", \"got_revision_cp\": \"refs/heads/master@{#863661}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"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-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4262b46f9d7b76c4ec2adf0e12bb6444567f409b\", \"swarm_hashes_refs/heads/master(at){#863661}_without_patch\": {\"absl_hardening_tests\": \"a07e418a75606e525bd143575b739bfff84954f3\", \"accessibility_unittests\": \"c9a125c1c4fbcda5b3e11a3014b0424cdcc95d39\", \"angle_unittests\": \"62d29e3774fbd7faba30a2f348efea9efe5add25\", \"app_shell_unittests\": \"224ccdb2325b10644502b61e7f7575a403a75ff2\", \"aura_unittests\": \"1e507a174053f1cfadbb0a6d7735f3bc45d61de3\", \"base_unittests\": \"08ebc4f3982febd199156f0fe4dfdbb3131e20f3\", \"base_util_unittests\": \"bdb28f4491f32e5e54046890fdfd6eea2fa3dc28\", \"blink_common_unittests\": \"9e21fbcdfd01154c336ed75880ef1d2654bc0bd3\", \"blink_fuzzer_unittests\": \"56af6848d9d47cd8393b38d9c601dbd7675e4307\", \"blink_heap_unittests\": \"1226d36b8ae300c70390b19f668aabf55672dcca\", \"blink_platform_unittests\": \"941b11ccba4f8e797c09531b6e901bb27de2d4a8\", \"blink_python_tests\": \"d8bac2524c9b9b9d424c6140a3c46297b37016b1\", \"blink_unittests\": \"a37a8be149690dacf0e6c11119e4f84254717063\", \"blink_web_tests\": \"33b5bbd78729549ffad1cd1e0749bcc7d23896ee\", \"boringssl_crypto_tests\": \"d9115ea3a1e451d2d2aa52f70a4a051b637ef5e8\", \"boringssl_ssl_tests\": \"2e4127e2da9ee22327cee257c68519404e513f2a\", \"browser_tests\": \"bc48fa3a9516059c56f8a60a9ecd2ac32ef3e09d\", \"capture_unittests\": \"a94b3134a8cdd0e3b030fc7b78baf7c41de70ec7\", \"cast_unittests\": \"5a7bfd42d01898ac0a54eb1a868b10239aa6cb20\", \"cc_unittests\": \"1d5c5b643dd554ba622f923ff05137707365dc51\", \"chrome_app_unittests\": \"3f9e78155908c59522a2fc81bd561871c1d49d57\", \"chromedriver_unittests\": \"378ef9c9691c8f28090a1e0ef9d0c1d9152df9f9\", \"color_unittests\": \"1ef56bf0e0677277baef4cc30bdf8fefbb2a9790\", \"components_browsertests\": \"c2a6e1b10ab8586e1029fedd9d762bf2cb8f888f\", \"components_unittests\": \"a10ae319e9ea9eb03bbccc842891e0f755eb99e4\", \"compositor_unittests\": \"4c55acd6e9d7f0ebaa202010e2744ad35b804aaf\", \"content_browsertests\": \"58f182e472db97bf5ae40ea2c8abf294e3b63c6e\", \"content_shell_crash_test\": \"0ac987c162d33ab7a8946ac4d8004ef92c9489a4\", \"content_unittests\": \"0816643f35b15f966df49e186dc9146cbbdccc63\", \"crashpad_tests\": \"f9eecfcc20b0f4a1938a28c3554f8d12f3b6a57d\", \"cronet_tests\": \"0fd537ee37dcaa2bab32cd48a516541830bade52\", \"cronet_unittests\": \"87ad7b3a036127aac2e25ed7057c04fe76a3f661\", \"crypto_unittests\": \"fd190a34ec1fb434bef4beac466c6436faa7ff20\", \"dbus_unittests\": \"d48cba979429cd8f539f9923131ff1c83220b13a\", \"device_unittests\": \"b45b2c3f954a0e7e1d4114ec98a14e392ce8d0f4\", \"display_unittests\": \"944716bde528015135890ddb357092d2e39e8d97\", \"events_unittests\": \"f4264d563ddcb0d8d86aaa8d0bc5a8633193bb24\", \"extensions_browsertests\": \"10c5f00831c382079a9e09e39f0173a8393f8a2d\", \"extensions_unittests\": \"6e7ae76579a2ecfe0c07791dafa13ad79d193288\", \"filesystem_service_unittests\": \"2c9b41d862c96aec4fc11bfce5e058c2cf13202d\", \"flatbuffers_unittests\": \"d83f4dd9fbf028cdd5733de38f9126e58761f6ea\", \"gcm_unit_tests\": \"96ac97b443b7b99074a80f5a0c296abdb8cebc4f\", \"gfx_unittests\": \"faacd407bbdff06dff9613883ca38e34a323318f\", \"gin_unittests\": \"88db859b718f9c3ba2110ac6b093a253e364c1cc\", \"google_apis_unittests\": \"30fb99e39cf03869d00c5255ada1c1d04734f27e\", \"gpu_unittests\": \"f04d0e35377057e74cf3c8e3aaf5db3543c6148c\", \"grit_python_unittests\": \"a6a82a347c5ac19643f71ece0eaa364aa5fca490\", \"gwp_asan_unittests\": \"0c9c62b397b08b433266b8bd08b6095ff94f9db8\", \"headless_browsertests\": \"97fd38e0e58b11d29400ce06fdff36ae80d100d8\", \"headless_unittests\": \"324882156391eb42a3c6a6acba6d3c4b64a66aff\", \"interactive_ui_tests\": \"b0400fce40d7da0d3bfd5124ef0a83cc7523ec94\", \"ipc_tests\": \"c93b3afaf21a0c41de3bbb0b5db533c2bd953f20\", \"jingle_unittests\": \"37c06289d6576afcb51a2d264b9a5db25fecad55\", \"latency_unittests\": \"67d768b6eac9d4a399c7fd4b718be0053886e8b0\", \"libjingle_xmpp_unittests\": \"233bd4471f9dd4ecf8d9f85d011417b01d3c3741\", \"liburlpattern_unittests\": \"d7ef1f906ffe2d87c152a1353238516be46ab17e\", \"media_blink_unittests\": \"9b4a7874f818a7db92b48253240b923033d30bf0\", \"media_unittests\": \"02be7c0a98c7fa77de39785d779fea0cae7807ea\", \"message_center_unittests\": \"22e27da92f6efa89f458fbb938476df557f4838d\", \"metrics_python_tests\": \"483139fae1177ac75e18359565d986810356defb\", \"midi_unittests\": \"a5173679835f329aed203ae4f492b6051cdbb6fb\", \"mojo_core_unittests\": \"4686333387cf9d313c78b20e28076ceae30298a5\", \"mojo_unittests\": \"90b77fcaf06a7a6b1c1d9ef287af341d9970cbae\", \"nacl_helper_nonsfi_unittests\": \"c621ee162f73b2347914d2c3a03c297372e3db2a\", \"nacl_loader_unittests\": \"c8f6b6d296940d2ac88a5372b45ef7b1269d2b7d\", \"native_theme_unittests\": \"b2328236065d014f689d4d372861f7eca3bc677e\", \"net_unittests\": \"2509cfdf379fdb5562fea9f6bef406e8c034d133\", \"openscreen_unittests\": \"5d9198aa96a6323a0324981408b988df999749e2\", \"pdf_unittests\": \"d9a7b4edbcc28e223aaaed41a29d8bf789eda31f\", \"perfetto_unittests\": \"c7bf9c5e9ece4dacdaac4f1dacbbdf52a272383a\", \"ppapi_unittests\": \"9c6065dc0c1aa4fb6a841fb077c740ec302c2ece\", \"printing_unittests\": \"bc345083da3222d217fac592ea444314e7d8ab98\", \"remoting_unittests\": \"9480866f4de2009bb85738a1c6b65b94c080f33d\", \"sandbox_linux_unittests\": \"d0ff36c71bd402ec9e34fd8ea82ebe08074fbeab\", \"service_manager_unittests\": \"15e27b5d9dc7503fca6a8019142a9912bfd6caa4\", \"services_unittests\": \"cd386cf35ddf988bfbe113db6e7ef79f4f745ac3\", \"shell_dialogs_unittests\": \"5ba4108cecb63605c8c1db7aa3b7a11a40d3401a\", \"skia_unittests\": \"958d1a5593791d1c03a113cfc756385cca54ae60\", \"snapshot_unittests\": \"4e0359cb77cd54c51bc92beb6b1dc0d86a2d49a3\", \"sql_unittests\": \"a7cdeb6a2abf2ffafe6c54cb6bc3cf752330bc56\", \"storage_unittests\": \"c8fc033b532b03512990a4277d20886e21a58023\", \"sync_integration_tests\": \"f78c4f78c0be79e738d2d0ff0b24ec7f3f2d2567\", \"telemetry_gpu_unittests\": \"8d4cfb117564b3d3b00c651d9aae43f44020a913\", \"telemetry_perf_unittests\": \"0af2827a57be27850eb8e7c3b2a998478e4c5e17\", \"telemetry_unittests\": \"b8fec6655e6f31590c12d1b41da51e7ab2ae5fbb\", \"traffic_annotation_auditor_unittests\": \"f5b04915ee4497f5e45cda509009c1eecc705c49\", \"ui_base_unittests\": \"6bf2895df3fa66568e165f27c7a6905b670c71ed\", \"ui_touch_selection_unittests\": \"fddb02b952c6f2b5dcb739aa252a78c9f0bb5923\", \"unit_tests\": \"7b19cee157cf389c0cc9272bc28c6dbd3a23c90e\", \"url_unittests\": \"dec4b488e0f1b06fc0fec17b99fbb62edc6e13c2\", \"views_perftests\": \"46dd1db906185b70010ca674e7e335a3a07175b8\", \"views_unittests\": \"d1a7448e910ac70143680e9efcb5ffd0f1449f10\", \"viz_unittests\": \"d42bb7f0163a3f2a04b3f27a8c14d9d3903c2d82\", \"vr_common_unittests\": \"a3977d55e9c1db3bcf9e42f31a2bcf8364a29b4d\", \"vr_pixeltests\": \"36e915100e8061587163e3162a1196d67048dbc3\", \"webdriver_wpt_tests\": \"ccc32e7dd7760c1e7561fdef5347fc688373dd19\", \"weblayer_browsertests\": \"3dcd76204763544a90866f71c39c5cdefede1e34\", \"weblayer_unittests\": \"cee1bb25676b2674088f5f0431326345d3985537\", \"wm_unittests\": \"599500cf128ec7b53fac864438203d605f464a64\", \"wtf_unittests\": \"c6a4bb376c435b69fa163829cdd680df880d0029\", \"x11_unittests\": \"3404ec6a4265cfe6e2ed28d3559720a6146ee814\", \"xr_browser_tests\": \"c8b68f874b9ddd4319927d9cd9d7e1edf75ee1a8\", \"zlib_unittests\": \"ed76ca1a6666675dca951fbd1843298b68229073\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_9bfd7171a3bbd1a8f2af02f1311f913ecc6693b330c40ec1ccf845ae76a71675_v2\", \"builder_dcef017f754690f3e0b2809d85023c2a50e42950d4504e0de4071c06ccf1a2cc_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_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-105-er0e\"], \"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": "1615963253314894",
"status": "COMPLETED",
"status_changed_ts": "1615966710450943",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181444",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4262b46f9d7b76c4ec2adf0e12bb6444567f409b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017963533333448176",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852533471251969088/+/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:5257bb6143281910",
"user_agent:luci-scheduler"
],
"updated_ts": "1615966710455611",
"url": "https://ci.chromium.org/b/8852533471251969088",
"utcnow_ts": "1615966712146876"
}
}
[07:38:32.155] Invocation finished in 58m17.975682079s with status SUCCEEDED