[18:46:21.179] New invocation is queued and will start shortly
[18:46:25.164] Starting the invocation (attempt 1)
[18:46:25.202] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:46:25.202] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:46:25.203] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051710518558937280",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e61571564c8e6bcf5462fd71ff363a3ecb357ea7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051710518558937280",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"gitiles_ref:refs/heads/master"
]
}
[18:46:25.988] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583779585369550",
"id": "8886280453450024768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e61571564c8e6bcf5462fd71ff363a3ecb357ea7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583779585845786",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169535",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051710518558937280",
"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/8886280453450024768/+/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": "1583779585845925",
"url": "https://ci.chromium.org/b/8886280453450024768",
"utcnow_ts": "1583779585979813"
}
}
[18:46:25.988] Task URL: https://ci.chromium.org/b/8886280453450024768
[18:46:25.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:2:0) after 1m0s
[18:47:25.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:2:0)
[18:47:25.992] Timer tick, asking Buildbucket for the build status
[18:47:26.154] Build 8886280453450024768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:26.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:3:0) after 1m0s
[18:48:26.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:3:0)
[18:48:26.198] Timer tick, asking Buildbucket for the build status
[18:48:26.461] Build 8886280453450024768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:26.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:4:0) after 1m0s
[18:49:26.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:4:0)
[18:49:26.480] Timer tick, asking Buildbucket for the build status
[18:49:26.643] Build 8886280453450024768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:26.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:5:0) after 1m0s
[18:50:26.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:5:0)
[18:50:26.660] Timer tick, asking Buildbucket for the build status
[18:50:26.939] Build 8886280453450024768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:26.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:6:0) after 1m0s
[18:51:08.513] Received PubSub notification, asking Buildbucket for the build status
[18:51:08.686] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:26.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:6:0)
[18:51:26.916] Timer tick, asking Buildbucket for the build status
[18:51:27.119] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:27.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:8:0) after 1m0s
[18:52:27.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:8:0)
[18:52:27.176] Timer tick, asking Buildbucket for the build status
[18:52:27.305] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:9:0) after 1m0s
[18:53:27.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:9:0)
[18:53:27.325] Timer tick, asking Buildbucket for the build status
[18:53:27.406] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:10:0) after 1m0s
[18:54:27.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:10:0)
[18:54:27.477] Timer tick, asking Buildbucket for the build status
[18:54:27.591] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:11:0) after 1m0s
[18:55:27.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:11:0)
[18:55:27.641] Timer tick, asking Buildbucket for the build status
[18:55:27.743] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:12:0) after 1m0s
[18:56:27.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:12:0)
[18:56:27.785] Timer tick, asking Buildbucket for the build status
[18:56:27.906] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:27.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:13:0) after 1m0s
[18:57:27.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:13:0)
[18:57:27.980] Timer tick, asking Buildbucket for the build status
[18:57:29.205] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:29.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:14:0) after 1m0s
[18:58:29.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:14:0)
[18:58:29.252] Timer tick, asking Buildbucket for the build status
[18:58:29.592] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:29.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:15:0) after 1m0s
[18:59:29.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:15:0)
[18:59:29.681] Timer tick, asking Buildbucket for the build status
[18:59:30.064] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:30.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:16:0) after 1m0s
[19:00:30.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:16:0)
[19:00:30.151] Timer tick, asking Buildbucket for the build status
[19:00:30.258] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:30.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:17:0) after 1m0s
[19:01:30.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:17:0)
[19:01:30.287] Timer tick, asking Buildbucket for the build status
[19:01:30.604] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:30.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:18:0) after 1m0s
[19:02:30.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:18:0)
[19:02:30.604] Timer tick, asking Buildbucket for the build status
[19:02:30.726] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:19:0) after 1m0s
[19:03:30.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:19:0)
[19:03:30.749] Timer tick, asking Buildbucket for the build status
[19:03:30.980] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:30.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:20:0) after 1m0s
[19:04:31.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:20:0)
[19:04:31.083] Timer tick, asking Buildbucket for the build status
[19:04:31.172] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:31.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:21:0) after 1m0s
[19:05:31.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:21:0)
[19:05:31.217] Timer tick, asking Buildbucket for the build status
[19:05:31.369] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:31.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:22:0) after 1m0s
[19:06:31.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:22:0)
[19:06:31.401] Timer tick, asking Buildbucket for the build status
[19:06:31.559] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:31.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:23:0) after 1m0s
[19:07:31.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:23:0)
[19:07:31.627] Timer tick, asking Buildbucket for the build status
[19:07:31.899] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:31.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:24:0) after 1m0s
[19:08:31.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:24:0)
[19:08:31.881] Timer tick, asking Buildbucket for the build status
[19:08:32.141] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:32.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:25:0) after 1m0s
[19:09:32.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:25:0)
[19:09:32.406] Timer tick, asking Buildbucket for the build status
[19:09:32.677] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:32.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:26:0) after 1m0s
[19:10:32.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:26:0)
[19:10:32.760] Timer tick, asking Buildbucket for the build status
[19:10:32.994] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:32.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:27:0) after 1m0s
[19:11:33.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:27:0)
[19:11:33.076] Timer tick, asking Buildbucket for the build status
[19:11:33.425] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:33.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:28:0) after 1m0s
[19:12:33.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:28:0)
[19:12:33.586] Timer tick, asking Buildbucket for the build status
[19:12:33.822] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:33.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:29:0) after 1m0s
[19:13:33.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:29:0)
[19:13:33.901] Timer tick, asking Buildbucket for the build status
[19:13:34.302] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:30:0) after 1m0s
[19:14:34.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:30:0)
[19:14:34.347] Timer tick, asking Buildbucket for the build status
[19:14:34.536] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:34.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:31:0) after 1m0s
[19:15:34.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:31:0)
[19:15:34.557] Timer tick, asking Buildbucket for the build status
[19:15:34.784] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:34.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:32:0) after 1m0s
[19:16:34.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:32:0)
[19:16:34.844] Timer tick, asking Buildbucket for the build status
[19:16:35.162] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:35.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:33:0) after 1m0s
[19:17:35.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:33:0)
[19:17:35.296] Timer tick, asking Buildbucket for the build status
[19:17:35.490] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:35.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:34:0) after 1m0s
[19:18:35.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:34:0)
[19:18:35.486] Timer tick, asking Buildbucket for the build status
[19:18:35.692] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:35.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:35:0) after 1m0s
[19:19:35.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:35:0)
[19:19:35.860] Timer tick, asking Buildbucket for the build status
[19:19:37.256] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:37.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:36:0) after 1m0s
[19:20:37.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:36:0)
[19:20:37.319] Timer tick, asking Buildbucket for the build status
[19:20:37.481] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:37.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:37:0) after 1m0s
[19:21:37.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:37:0)
[19:21:37.539] Timer tick, asking Buildbucket for the build status
[19:21:37.673] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:37.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:38:0) after 1m0s
[19:22:37.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:38:0)
[19:22:37.773] Timer tick, asking Buildbucket for the build status
[19:22:38.005] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:38.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:39:0) after 1m0s
[19:23:38.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:39:0)
[19:23:38.075] Timer tick, asking Buildbucket for the build status
[19:23:38.189] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:38.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:40:0) after 1m0s
[19:24:38.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:40:0)
[19:24:38.253] Timer tick, asking Buildbucket for the build status
[19:24:38.391] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:38.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:41:0) after 1m0s
[19:25:38.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:41:0)
[19:25:38.475] Timer tick, asking Buildbucket for the build status
[19:25:38.578] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:38.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:42:0) after 1m0s
[19:26:38.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:42:0)
[19:26:38.613] Timer tick, asking Buildbucket for the build status
[19:26:38.762] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:38.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:43:0) after 1m0s
[19:27:38.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:43:0)
[19:27:38.935] Timer tick, asking Buildbucket for the build status
[19:27:39.028] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:39.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:44:0) after 1m0s
[19:28:39.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:44:0)
[19:28:39.118] Timer tick, asking Buildbucket for the build status
[19:28:39.343] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:39.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:45:0) after 1m0s
[19:29:39.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:45:0)
[19:29:39.373] Timer tick, asking Buildbucket for the build status
[19:29:39.761] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:39.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:46:0) after 1m0s
[19:30:39.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:46:0)
[19:30:39.804] Timer tick, asking Buildbucket for the build status
[19:30:40.470] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:40.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:47:0) after 1m0s
[19:31:40.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:47:0)
[19:31:40.492] Timer tick, asking Buildbucket for the build status
[19:31:40.681] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:40.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:48:0) after 1m0s
[19:32:40.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:48:0)
[19:32:40.810] Timer tick, asking Buildbucket for the build status
[19:32:40.977] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:40.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:49:0) after 1m0s
[19:33:41.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:49:0)
[19:33:41.058] Timer tick, asking Buildbucket for the build status
[19:33:41.282] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:41.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:50:0) after 1m0s
[19:34:41.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:50:0)
[19:34:41.408] Timer tick, asking Buildbucket for the build status
[19:34:41.521] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:41.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:51:0) after 1m0s
[19:35:41.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:51:0)
[19:35:41.593] Timer tick, asking Buildbucket for the build status
[19:35:41.739] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:41.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:52:0) after 1m0s
[19:36:41.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:52:0)
[19:36:41.797] Timer tick, asking Buildbucket for the build status
[19:36:42.118] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:42.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:53:0) after 1m0s
[19:37:42.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:53:0)
[19:37:42.177] Timer tick, asking Buildbucket for the build status
[19:37:43.057] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:43.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:54:0) after 1m0s
[19:38:43.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:54:0)
[19:38:43.114] Timer tick, asking Buildbucket for the build status
[19:38:43.236] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:43.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:55:0) after 1m0s
[19:39:43.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:55:0)
[19:39:43.235] Timer tick, asking Buildbucket for the build status
[19:39:43.482] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:43.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:56:0) after 1m0s
[19:40:43.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:56:0)
[19:40:43.564] Timer tick, asking Buildbucket for the build status
[19:40:43.725] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:43.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:57:0) after 1m0s
[19:41:43.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:57:0)
[19:41:43.804] Timer tick, asking Buildbucket for the build status
[19:41:43.914] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:43.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:58:0) after 1m0s
[19:42:43.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:58:0)
[19:42:43.955] Timer tick, asking Buildbucket for the build status
[19:42:44.082] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:44.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:59:0) after 1m0s
[19:43:44.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:59:0)
[19:43:44.256] Timer tick, asking Buildbucket for the build status
[19:43:44.566] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:44.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:60:0) after 1m0s
[19:44:44.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:60:0)
[19:44:44.585] Timer tick, asking Buildbucket for the build status
[19:44:44.669] Build 8886280453450024768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:44.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051710518558937280:61:0) after 1m0s
[19:45:42.546] Received PubSub notification, asking Buildbucket for the build status
[19:45:42.762] Build 8886280453450024768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:45:42.762] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583783141478353",
"created_by": "project:chromium",
"created_ts": "1583779585369550",
"id": "8886280453450024768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e61571564c8e6bcf5462fd71ff363a3ecb357ea7\"}}",
"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\"}, \"$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-72-fw9e\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169535, \"got_angle_revision\": \"f77f10f33266a3ea55b41f946f8d971c720e0374\", \"got_dawn_revision\": \"532be50b761b660e2e5e354bbffb5b020df9afef\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"e61571564c8e6bcf5462fd71ff363a3ecb357ea7\", \"got_revision_cp\": \"refs/heads/master@{#748313}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8be72df6046231eedbd14d155a5a9484bda217c1\", \"got_v8_revision\": \"3c2d9f15b6f6c156fcc42cb6251806595664535c\", \"got_v8_revision_cp\": \"refs/heads/8.2.272@{#1}\", \"got_webrtc_revision\": \"f87536c9de24ce25c398c1f7a413dc8b80208362\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30724}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e61571564c8e6bcf5462fd71ff363a3ecb357ea7\", \"swarm_hashes_refs/heads/master(at){#748313}_without_patch\": {\"accessibility_unittests\": \"89fbaba865cd6c0672d4c5feff308e300f0870d0\", \"angle_unittests\": \"ba11135f9d3077c2c571293f7d87ef26594603d0\", \"app_shell_unittests\": \"76203bf1cad93eed48ec15c660d9cfed6246033d\", \"aura_unittests\": \"5c5427487bcf7dccdb644b347d21f18cad6ac0f4\", \"base_unittests\": \"5641a4e4f6bdb703b312cab72ec6ff83fb9b0bf0\", \"base_util_unittests\": \"d1e8abfec817fd1252468e11a55764aa9ce19038\", \"blink_common_unittests\": \"9e6dd58971bbc37dc4829d6924dba964cbb10e71\", \"blink_fuzzer_unittests\": \"fb27a6391feecd9479a68fc59c98192f8e7d44d9\", \"blink_heap_unittests\": \"690ea106b3c1b65feecfa1e6fa6ea07f0c7117c9\", \"blink_platform_unittests\": \"6c28813be7f8d87642d5959a7a4422e5a1d2c004\", \"blink_python_tests\": \"a21e49a539878b539635a8e2f351c51465b793ff\", \"blink_unittests\": \"a0adc035e9411662af95d3307998ca6684343098\", \"blink_web_tests\": \"fd122084641ce92e298deac17b58142dd8483a0c\", \"boringssl_crypto_tests\": \"d8fd1d98548abcd6eea92e26c9b328f46483c656\", \"boringssl_ssl_tests\": \"18ac8c64ead4b9984b07a3717efdc103e8e7577e\", \"browser_tests\": \"e15fe62c0c2da43c020069aae87e3e8fd663d3c9\", \"cacheinvalidation_unittests\": \"58369ddf2e000614d6142c7d62bda777dd1726ad\", \"capture_unittests\": \"998bb3d960dab266247c78c9915b4bce442011be\", \"cast_unittests\": \"aab49a7c331f7cacabc5435c1c07b53b191acf32\", \"cc_unittests\": \"64bafc2a99a7335b19ad7b606a808031bb2c7b19\", \"chrome_app_unittests\": \"ebddc754c1b668fc9d0fc98a037e5c6c81b0c6f6\", \"chromedriver_unittests\": \"e2e639408f560424b8bcd8b5176b05b72a2b13a9\", \"components_browsertests\": \"8a6efdbc5f58bc2fe6047573f0883164df4b1523\", \"components_unittests\": \"df0fc0fa49db1f3d1883b54d6cdbedd1dade7ebd\", \"compositor_unittests\": \"8e0b6c7f5e4c2312d18d0fc4d62e3e4122feb432\", \"content_browsertests\": \"933b1853367235c7a4005e426eada087dd385690\", \"content_shell_crash_test\": \"8400032a9fa85214c436813eb96494b829619e6f\", \"content_unittests\": \"ad24773b514743ad3d8464f6c9e433f7f7bc89a7\", \"crashpad_tests\": \"3f75bf2d1ed713ca0b910503d14f6cf5baf08dff\", \"cronet_tests\": \"6b2648284c9a069448c12405bfbd2bdb05569937\", \"cronet_unittests\": \"a96655192d227ae595abe604c567c38b6cc08b03\", \"crypto_unittests\": \"be512070d9ae9c13b8b6f99438d55c093a4b3706\", \"dbus_unittests\": \"fc36b049d8a3277bc0d60262795af238002c1f43\", \"device_unittests\": \"a73e95f99640241270b2ebacdef49eaf57627e33\", \"display_unittests\": \"9954745240393450a46a20150a38c54ecf91512e\", \"events_unittests\": \"c18010d5ebe9ab297fec6c06ce8445a4957ce339\", \"extensions_browsertests\": \"2b4b4c214cbabe764c69ea4ad62863cfe573479a\", \"extensions_unittests\": \"2d37b7744c85d606590e2d4809f4f242b26d1925\", \"filesystem_service_unittests\": \"9bfd60e178aba1306cfbd7fb2ef69f065d7b398a\", \"flatbuffers_unittests\": \"050844e0d26621703adfe93dfd2f97054fb85d6c\", \"gcm_unit_tests\": \"0c775cbc9ceac3952ce54819e24400871193f2d0\", \"gfx_unittests\": \"edb04d417b36d02ef2f1e42d340bdfa6330c8df6\", \"gin_unittests\": \"2885bc045ebbaef873ad5dfda4967bd3ed094c12\", \"google_apis_unittests\": \"31d54145eb24eda56dfce98b74b12ed3d50183de\", \"gpu_unittests\": \"8bacb7ef9c6cb34af95b14d4ae772b389b389d0e\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"2fa735098a4f4332e2aee433c11a089a09296de2\", \"headless_browsertests\": \"f234a53bba9f95b6b28ea9c32c1c454464d20b95\", \"headless_unittests\": \"d474fcf53097378b15fc648cf390fcc9e21d4ba1\", \"interactive_ui_tests\": \"feb38a9b89be9462980c6fd3ead0546f73ad4b85\", \"ipc_tests\": \"584124bdbc6a0dd2bca85142ee7b7fcd25bd094a\", \"jingle_unittests\": \"f938202745e8e9d8e3bf658f4fc25a63aa347a84\", \"latency_unittests\": \"a2d23d6682a19d3e41a1b0f2eb1172e04819d835\", \"libjingle_xmpp_unittests\": \"6f524c3007b7b93e92fa36c7601e26798e6d5112\", \"media_blink_unittests\": \"a2eab0c1ac256bc245cf8ae5342fa85c495ce1bc\", \"media_service_unittests\": \"b7e964899d9b967083ddfea860e357893b4766b9\", \"media_unittests\": \"22847d6d441f00e48694423a90e0778927123faf\", \"message_center_unittests\": \"719830c14b3795ebb57fa66ef7005acf97f58dc4\", \"metrics_python_tests\": \"3bfbfbf35ae09362e2bdfbe7c7b9cb1fbdc14e7a\", \"midi_unittests\": \"a21977be6277d1af9f8795c7f73d03fe7359662a\", \"mojo_core_unittests\": \"5cddb676170a6268e3432f328830ff89eeedc0de\", \"mojo_unittests\": \"6cf9c4454b14537c5fe8e85e3e11d72f1c32039f\", \"nacl_helper_nonsfi_unittests\": \"56d500f2b6fcb6d06abb9240d24617aaf8d05f75\", \"nacl_loader_unittests\": \"786c12b43544f27b17a1c5792822aa8f7c0e0568\", \"native_theme_unittests\": \"14544f468a6de0ecd66b879018801029eaee71c7\", \"net_unittests\": \"e7a88e2abc878501e0e8d27b2184207f9775829f\", \"pdf_unittests\": \"3486b6e503142821937b4917655e3b5d4aca8d3b\", \"perfetto_unittests\": \"f8f8a91452d824144fcac9c43811ca27ee067303\", \"ppapi_unittests\": \"3aba803509bf88a5dea626045fd35e85ca5bc3b1\", \"printing_unittests\": \"f230550594842ceceb5dbf5a4c584d3e5d72e707\", \"remoting_unittests\": \"44a03d049865ad93b358f83a0f0533e59bd4592b\", \"sandbox_linux_unittests\": \"36496d61bd43c286c7a27b2989c477e02860ebc1\", \"service_manager_unittests\": \"152c1bffd3b5293d299003e8cb98e722ab843650\", \"services_unittests\": \"d556a6344259affdaa74baa20706fad7cf942349\", \"shell_dialogs_unittests\": \"b7b537789f92a558d3c062ed5cc650e415f8b556\", \"skia_unittests\": \"416ad0be99803c81cd79fdf16b916d6989d17e76\", \"snapshot_unittests\": \"d9d1fd3249bf1b3ef08b919bd281090f2ffd3f0c\", \"sql_unittests\": \"6ea2542f55f247260649ec666d661ccbc1291eee\", \"storage_unittests\": \"6b811deba1e34c97b206dcd5acfefa6173336541\", \"sync_integration_tests\": \"587afb2966cd71bd8fecde1af2ccf9f3c65418eb\", \"telemetry_gpu_unittests\": \"2df5ce2a9cddec4cd80604d047cca74142dbe7d1\", \"telemetry_perf_unittests\": \"86e89ddf4335b26e525f8f48ecd6222e25a55fb6\", \"telemetry_unittests\": \"cdfa8030cb28d4bdaf0c5529024d5be22ff0bb46\", \"traffic_annotation_auditor_unittests\": \"c2755bf5dfd0d18deb17497d5e6659f7d2844727\", \"ui_base_unittests\": \"4ef288944cf21f24c45150ae948cbd328df6378b\", \"ui_touch_selection_unittests\": \"788bc50077ded6b4a5037cf75745937f034196aa\", \"unit_tests\": \"0a64ebd4025ffacc0605e5b82ee17fa8997b807e\", \"url_unittests\": \"47c1ab7a340a9cbb347dd074033a54e8d5de6cba\", \"views_perftests\": \"1ea01a4af478333c033ece19c5d1b9c0ce7861a0\", \"views_unittests\": \"550826caf0530321ca568ceb6f3eafea9f065ba9\", \"viz_unittests\": \"0b8da541e41548b93e454aa8eca52a1e3abfe5e7\", \"vr_common_unittests\": \"c76c5a8df57e91a4f0dd18b3d757e6ad881b56b9\", \"vr_pixeltests\": \"098abe7d1ab4dd023ed1a0639903746999355710\", \"webdriver_wpt_tests\": \"aa9e257438b9d2c90776804d5a8dd384b5d754b9\", \"weblayer_browsertests\": \"508a2c376f059b0a61873e0964002350535171e6\", \"wm_unittests\": \"1a60f605b6799d9fc09343f8876b8a3f3d8f8370\", \"wtf_unittests\": \"c0f55f75184af14355a059130cec5e8ae198605c\", \"xr_browser_tests\": \"0d40bd47c26ed82c1b6ecfff9e1366141db2cd98\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_8b7b2365a8f3880d050d5bb210d6d23a3c1fa90e9cf635ebce9fc15f785b82f2_v2\", \"builder_bf333895421fefa78318d8049b60faf5c230ceed823f417948b15e1b2d972d6c_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_ddf530b99db2c48999a16b04f27f886d0f06df616543b36733eb8d0558bd23f5_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-72-fw9e\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583779865658344",
"status": "COMPLETED",
"status_changed_ts": "1583783142101134",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169535",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e61571564c8e6bcf5462fd71ff363a3ecb357ea7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051710518558937280",
"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/8886280453450024768/+/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:4ad97028ff546610",
"user_agent:luci-scheduler"
],
"updated_ts": "1583783142108921",
"url": "https://ci.chromium.org/b/8886280453450024768",
"utcnow_ts": "1583783142745392"
}
}
[19:45:42.762] Invocation finished in 59m21.648188282s with status SUCCEEDED