[08:11:54.704] New invocation is queued and will start shortly
[08:11:56.376] Starting the invocation (attempt 1)
[08:11:56.412] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:11:56.412] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:11:56.412] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053471776462331392",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"262a71bd3d3271cceb44c4e034efccc1bd3cb5a9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053471776462331392",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"gitiles_ref:refs/heads/master"
]
}
[08:11:58.515] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582099916518364",
"id": "8888041713895635856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"262a71bd3d3271cceb44c4e034efccc1bd3cb5a9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582099916949558",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168781",
"builder:Linux Builder (dbg)",
"buildset:commit/git/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053471776462331392",
"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/8888041713895635856/+/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": "1582099916949824",
"url": "https://ci.chromium.org/b/8888041713895635856",
"utcnow_ts": "1582099918501014"
}
}
[08:11:58.515] Task URL: https://ci.chromium.org/b/8888041713895635856
[08:11:58.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:2:0) after 1m0s
[08:12:58.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:2:0)
[08:12:58.586] Timer tick, asking Buildbucket for the build status
[08:12:58.821] Build 8888041713895635856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:58.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:3:0) after 1m0s
[08:13:58.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:3:0)
[08:13:58.885] Timer tick, asking Buildbucket for the build status
[08:13:59.353] Build 8888041713895635856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:59.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:4:0) after 1m0s
[08:14:59.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:4:0)
[08:14:59.396] Timer tick, asking Buildbucket for the build status
[08:14:59.796] Build 8888041713895635856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:59.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:5:0) after 1m0s
[08:15:59.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:5:0)
[08:15:59.790] Timer tick, asking Buildbucket for the build status
[08:15:59.897] Build 8888041713895635856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:59.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:6:0) after 1m0s
[08:16:02.314] Received PubSub notification, asking Buildbucket for the build status
[08:16:02.375] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:59.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:6:0)
[08:16:59.907] Timer tick, asking Buildbucket for the build status
[08:17:00.121] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:00.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:8:0) after 1m0s
[08:18:00.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:8:0)
[08:18:00.147] Timer tick, asking Buildbucket for the build status
[08:18:00.267] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:00.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:9:0) after 1m0s
[08:19:00.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:9:0)
[08:19:00.288] Timer tick, asking Buildbucket for the build status
[08:19:00.398] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:00.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:10:0) after 1m0s
[08:20:00.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:10:0)
[08:20:00.420] Timer tick, asking Buildbucket for the build status
[08:20:00.595] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:00.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:11:0) after 1m0s
[08:21:00.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:11:0)
[08:21:00.615] Timer tick, asking Buildbucket for the build status
[08:21:00.881] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:00.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:12:0) after 1m0s
[08:22:00.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:12:0)
[08:22:00.904] Timer tick, asking Buildbucket for the build status
[08:22:00.976] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:00.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:13:0) after 1m0s
[08:23:01.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:13:0)
[08:23:01.098] Timer tick, asking Buildbucket for the build status
[08:23:01.213] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:01.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:14:0) after 1m0s
[08:24:01.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:14:0)
[08:24:01.267] Timer tick, asking Buildbucket for the build status
[08:24:01.377] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:01.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:15:0) after 1m0s
[08:25:01.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:15:0)
[08:25:01.463] Timer tick, asking Buildbucket for the build status
[08:25:01.576] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:16:0) after 1m0s
[08:26:01.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:16:0)
[08:26:01.624] Timer tick, asking Buildbucket for the build status
[08:26:01.781] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:01.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:17:0) after 1m0s
[08:27:01.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:17:0)
[08:27:01.815] Timer tick, asking Buildbucket for the build status
[08:27:01.960] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:01.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:18:0) after 1m0s
[08:28:02.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:18:0)
[08:28:02.028] Timer tick, asking Buildbucket for the build status
[08:28:02.367] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:02.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:19:0) after 1m0s
[08:29:02.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:19:0)
[08:29:02.459] Timer tick, asking Buildbucket for the build status
[08:29:02.535] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:02.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:20:0) after 1m0s
[08:30:02.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:20:0)
[08:30:02.590] Timer tick, asking Buildbucket for the build status
[08:30:02.954] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:02.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:21:0) after 1m0s
[08:31:02.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:21:0)
[08:31:02.991] Timer tick, asking Buildbucket for the build status
[08:31:03.254] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:03.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:22:0) after 1m0s
[08:32:03.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:22:0)
[08:32:03.321] Timer tick, asking Buildbucket for the build status
[08:32:03.679] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:03.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:23:0) after 1m0s
[08:33:03.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:23:0)
[08:33:03.730] Timer tick, asking Buildbucket for the build status
[08:33:03.954] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:03.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:24:0) after 1m0s
[08:34:04.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:24:0)
[08:34:04.035] Timer tick, asking Buildbucket for the build status
[08:34:04.120] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:04.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:25:0) after 1m0s
[08:35:04.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:25:0)
[08:35:04.140] Timer tick, asking Buildbucket for the build status
[08:35:04.547] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:04.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:26:0) after 1m0s
[08:36:04.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:26:0)
[08:36:04.590] Timer tick, asking Buildbucket for the build status
[08:36:05.053] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:05.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:27:0) after 1m0s
[08:37:05.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:27:0)
[08:37:05.176] Timer tick, asking Buildbucket for the build status
[08:37:05.387] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:05.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:28:0) after 1m0s
[08:38:05.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:28:0)
[08:38:05.404] Timer tick, asking Buildbucket for the build status
[08:38:05.495] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:05.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:29:0) after 1m0s
[08:39:05.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:29:0)
[08:39:05.613] Timer tick, asking Buildbucket for the build status
[08:39:05.714] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:05.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:30:0) after 1m0s
[08:40:05.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:30:0)
[08:40:05.718] Timer tick, asking Buildbucket for the build status
[08:40:05.820] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:05.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:31:0) after 1m0s
[08:41:05.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:31:0)
[08:41:05.841] Timer tick, asking Buildbucket for the build status
[08:41:05.926] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:05.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:32:0) after 1m0s
[08:42:05.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:32:0)
[08:42:05.932] Timer tick, asking Buildbucket for the build status
[08:42:06.114] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:33:0) after 1m0s
[08:43:06.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:33:0)
[08:43:06.201] Timer tick, asking Buildbucket for the build status
[08:43:06.636] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:06.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:34:0) after 1m0s
[08:44:06.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:34:0)
[08:44:06.725] Timer tick, asking Buildbucket for the build status
[08:44:06.824] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:06.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:35:0) after 1m0s
[08:45:06.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:35:0)
[08:45:06.898] Timer tick, asking Buildbucket for the build status
[08:45:06.995] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:06.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:36:0) after 1m0s
[08:46:07.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:36:0)
[08:46:07.022] Timer tick, asking Buildbucket for the build status
[08:46:07.121] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:07.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:37:0) after 1m0s
[08:47:07.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:37:0)
[08:47:07.109] Timer tick, asking Buildbucket for the build status
[08:47:07.483] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:07.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:38:0) after 1m0s
[08:48:07.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:38:0)
[08:48:07.507] Timer tick, asking Buildbucket for the build status
[08:48:08.093] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:08.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:39:0) after 1m0s
[08:49:08.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:39:0)
[08:49:08.148] Timer tick, asking Buildbucket for the build status
[08:49:08.455] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:08.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:40:0) after 1m0s
[08:50:08.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:40:0)
[08:50:08.508] Timer tick, asking Buildbucket for the build status
[08:50:08.778] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:41:0) after 1m0s
[08:51:08.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:41:0)
[08:51:08.821] Timer tick, asking Buildbucket for the build status
[08:51:08.991] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:08.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:42:0) after 1m0s
[08:52:08.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:42:0)
[08:52:08.978] Timer tick, asking Buildbucket for the build status
[08:52:09.146] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:09.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:43:0) after 1m0s
[08:53:09.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:43:0)
[08:53:09.208] Timer tick, asking Buildbucket for the build status
[08:53:09.390] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:09.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:44:0) after 1m0s
[08:54:09.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:44:0)
[08:54:09.547] Timer tick, asking Buildbucket for the build status
[08:54:09.655] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:09.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:45:0) after 1m0s
[08:55:10.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:45:0)
[08:55:10.089] Timer tick, asking Buildbucket for the build status
[08:55:10.269] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:10.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:46:0) after 1m0s
[08:56:10.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:46:0)
[08:56:10.795] Timer tick, asking Buildbucket for the build status
[08:56:10.946] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:10.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:47:0) after 1m0s
[08:57:11.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:47:0)
[08:57:11.154] Timer tick, asking Buildbucket for the build status
[08:57:11.317] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:11.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:48:0) after 1m0s
[08:58:11.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:48:0)
[08:58:11.400] Timer tick, asking Buildbucket for the build status
[08:58:11.786] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:11.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:49:0) after 1m0s
[08:59:11.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:49:0)
[08:59:11.958] Timer tick, asking Buildbucket for the build status
[08:59:12.163] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:50:0) after 1m0s
[09:00:12.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:50:0)
[09:00:12.260] Timer tick, asking Buildbucket for the build status
[09:00:12.637] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:51:0) after 1m0s
[09:01:12.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:51:0)
[09:01:12.960] Timer tick, asking Buildbucket for the build status
[09:01:13.121] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:52:0) after 1m0s
[09:02:13.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:52:0)
[09:02:13.187] Timer tick, asking Buildbucket for the build status
[09:02:13.479] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:53:0) after 1m0s
[09:03:13.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:53:0)
[09:03:13.506] Timer tick, asking Buildbucket for the build status
[09:03:14.865] Build 8888041713895635856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:14.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053471776462331392:54:0) after 1m0s
[09:03:41.494] Received PubSub notification, asking Buildbucket for the build status
[09:03:41.579] Build 8888041713895635856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:03:41.579] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582103020564564",
"created_by": "project:chromium",
"created_ts": "1582099916518364",
"id": "8888041713895635856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"262a71bd3d3271cceb44c4e034efccc1bd3cb5a9\"}}",
"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-30-j5wr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168781, \"got_angle_revision\": \"fa9eff37c38ac16927bc1a85cf3d570c1c8e5183\", \"got_dawn_revision\": \"0aa86a7ae8315f93f9501323dc082af0ac869efc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"262a71bd3d3271cceb44c4e034efccc1bd3cb5a9\", \"got_revision_cp\": \"refs/heads/master@{#742523}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8def9063c4fdefa8e644198d2254ef279952c88b\", \"got_v8_revision\": \"8962e435a6bc325c8443aa9779596a51eb40c523\", \"got_v8_revision_cp\": \"refs/heads/8.2.116@{#1}\", \"got_webrtc_revision\": \"1282babe6621d3a2084bbd24e77652e0b3a4eb93\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30549}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"262a71bd3d3271cceb44c4e034efccc1bd3cb5a9\", \"swarm_hashes_refs/heads/master(at){#742523}_without_patch\": {\"accessibility_unittests\": \"baaabe4ea4fdb9dcc371ea768bf4ec196ac483fc\", \"angle_unittests\": \"b127019534fa965c865c999ce5386c041d0c3ed5\", \"app_shell_unittests\": \"aaaaad9664d339ac3fda39353ee327250974ddfb\", \"aura_unittests\": \"4b9d38ec93b2ea78b7903730113fd76d98ff82c3\", \"base_unittests\": \"d89380744a36e0de940023eae2aaf800da772cd6\", \"base_util_unittests\": \"468deb0cf39f9fef5e3d18baa5a8609b86f47b57\", \"blink_common_unittests\": \"880d74e3bd103d740181f7f0f0af6bd2981e3e07\", \"blink_fuzzer_unittests\": \"71615a2d60cbae2c87aad41edfb0286f4971c9ee\", \"blink_heap_unittests\": \"dc107c2f6d8e2bed8c9e32b5dd6463d1d650a8a9\", \"blink_platform_unittests\": \"3ea441292363eadf8b263a4173ec4c841449a197\", \"blink_python_tests\": \"55e24d53eb12d26dbee45026b5f6f071c4699ebf\", \"blink_unittests\": \"01d42929ae1bdd3de8f648b2726c9dc2a0995e3a\", \"blink_web_tests\": \"6e739f43d72effaf8515ac4ee3ae4bf77aa6d5cb\", \"boringssl_crypto_tests\": \"9ca2279dbeb2756495ac34cf237e59358588fb48\", \"boringssl_ssl_tests\": \"53725b9d83fa01fe5ec43a0332dfbd8f52c4fb60\", \"browser_tests\": \"3dcdd02d0636cf774f49377e55a3becd8a4e81e3\", \"cacheinvalidation_unittests\": \"323e1e46995659bd764637a2e9c566a75979b25a\", \"capture_unittests\": \"765b70dbde352f0cb8611f025df62e11c0a47d9b\", \"cast_unittests\": \"5c5ac24e68cf317a55c521b1fec771cc4670f952\", \"cc_unittests\": \"f36407b88ec969cc32118c72118fc88857a0dc07\", \"chrome_app_unittests\": \"94bc0e3b88f9dc1fbbfa255e97607206e46acaf5\", \"chromedriver_unittests\": \"8ea7c1667b6e84dcbf6699449f5ed7073fb604cf\", \"components_browsertests\": \"21c3ef09246c8fafa9d8bc9685108ab7869825c8\", \"components_unittests\": \"3ea01489846672a8e5d47ed07a5a3c21948234a2\", \"compositor_unittests\": \"24918063f958993c085cf67fbfb91ccf62d6bfe1\", \"content_browsertests\": \"6872f250425cfeb54e879c73e48e5b818a2ac689\", \"content_shell_crash_test\": \"af622e08c3122799d5a22c20c97676b8b6947b71\", \"content_unittests\": \"0e07dc1d555260522f5ffdebca643b1825580f23\", \"crashpad_tests\": \"cac984c945cbf6f7dc7781448e6b591e2483edc7\", \"cronet_tests\": \"4a7a61c7246291843652178dbe3865c57163fb35\", \"cronet_unittests\": \"ad69404adb6c48023f33525f34f1376c4c3dff49\", \"crypto_unittests\": \"ab56a15fa4e09b3c0b965c33675a2577453d78bf\", \"dbus_unittests\": \"84c4dff3925f67cd30fa0a97555595f347a67ca8\", \"device_unittests\": \"6e6f1879353a4e1e666313d2fdee930439010183\", \"display_unittests\": \"c69f39258c60990803a99305eb848467b9e37fdd\", \"events_unittests\": \"40938b65e6c6ff5daeaf34529e99ada5560376a6\", \"extensions_browsertests\": \"cdd5e405aa0f21cc4d30ebe200665ddee2ecfcc2\", \"extensions_unittests\": \"30b256e69954302d5bb8bea7d4907f28bf59945d\", \"filesystem_service_unittests\": \"204b18ef90932d409b470ffd16ad02c69680999c\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"76c29eef0b5c0a8e1f2699d767ab2300a3eb629d\", \"gfx_unittests\": \"857574cf5c9ca67a0d9a3c0d4fb519f950293021\", \"gin_unittests\": \"da8dd49db11bac120ae4a4aa522dc8df3c317930\", \"google_apis_unittests\": \"c3efd2f9fbc0c5c5ddd2df6d116d9aaa5a07fd96\", \"gpu_unittests\": \"b0a449dc56c17040c6a8207e04cedb06360956b9\", \"grit_python_unittests\": \"0a186e54539d3475bae4b9d19cc134d9a92e2108\", \"gwp_asan_unittests\": \"07223e118d9ad92e1d3a8c532b700b0a720fed09\", \"headless_browsertests\": \"aad65945f066443f8a0d4cb827602b7ce2c2feac\", \"headless_unittests\": \"1717a516fa21d4b6c80e001482d4ff8a84924dc6\", \"interactive_ui_tests\": \"730a9d976f9e60c297eff7c73ddc2b4ea2e7158d\", \"ipc_tests\": \"847f100249d3b829734c67c475b96751a9a82789\", \"jingle_unittests\": \"8efdab78803fbca5676f2c68a8d0f009a0998397\", \"latency_unittests\": \"fd4a1741a206f0ce98921d316f88b61f25f2c24e\", \"libjingle_xmpp_unittests\": \"64b3ad16211594845e3aa5a0f7cb1ca7c9a27c67\", \"media_blink_unittests\": \"7a65678d2cabde50579fa94301d1df555c53cd84\", \"media_service_unittests\": \"a7729da3ed7ff464436e65245f933bb2344109c6\", \"media_unittests\": \"dbc5310b870dadeb7eab63cd0cfaac0d94d46c59\", \"message_center_unittests\": \"a124b76434462a977465c84e52330bd40521b00a\", \"metrics_python_tests\": \"f594a7f85d7e1d88c72af5476e5da029644be3de\", \"midi_unittests\": \"97e10c14c72b1787aecae911313ee20124128881\", \"mojo_core_unittests\": \"d2afda697258ebc3c22b885bf6c18188593f39e1\", \"mojo_unittests\": \"83335611d8f0c259622666a6cbddb43d68663b0c\", \"nacl_helper_nonsfi_unittests\": \"9dad0cdf1df497baf07ecef7be5eb9bb122cbbc4\", \"nacl_loader_unittests\": \"aaac223c6edcc9c0cb10d48920085ce3aef93b23\", \"native_theme_unittests\": \"8df8f2139e9aa9ef4d803e099739f42afbb08016\", \"net_unittests\": \"21da8ac7ffb3e668ed1caea7b2f88f54a9da1a4a\", \"pdf_unittests\": \"1f23e529e8a363140e5babe76753e4ffdd298e5a\", \"perfetto_unittests\": \"16a1aa16394f7d0420398f8c436b16de89b9bb66\", \"ppapi_unittests\": \"125b58d2e731478a0031dba49f33ba1df720d6bf\", \"printing_unittests\": \"c368cfa975b512c681b6f6cc60c896472bcd3525\", \"remoting_unittests\": \"1308bc966f18183f28386170774f40afb33fa867\", \"sandbox_linux_unittests\": \"49333a7bacfab78ba5f30b5b83a585b4aba61dcc\", \"service_manager_unittests\": \"ad4581b059f1217b1b857012c704c63ea063ed67\", \"services_unittests\": \"e071651fb9ce95169e4b6dd18b003f684abbb6b4\", \"shell_dialogs_unittests\": \"cca017aaf684d84b99c7b0a1cc766189665d1642\", \"skia_unittests\": \"c0e365d823360f15e485adce8b37eedd44291ecd\", \"snapshot_unittests\": \"a191e6fd98e56fdeffb3250a31bf633836cf347d\", \"sql_unittests\": \"17a985241baacb73b9c0b748806301ff4e7e3f64\", \"storage_unittests\": \"fa66b5b797b775f311ad679978951bd41358154d\", \"sync_integration_tests\": \"a98657dd7e3ebad781b44bf9e2a25df8216b06ec\", \"telemetry_gpu_unittests\": \"92b1c7774c0cffcb1d2d2f38d68bd73e7e6f587d\", \"telemetry_perf_unittests\": \"b26e334efbb213cb7b551f51433a4134b958c923\", \"telemetry_unittests\": \"b51bd83be7411ce2c944e917abaf7555f2d087d3\", \"traffic_annotation_auditor_unittests\": \"4af659be5115c836d5e56cf2a1936014f59db766\", \"ui_base_unittests\": \"6522e123bbb6f3744def1a92aac19a8ed5732f75\", \"ui_touch_selection_unittests\": \"c7e8cfc26096bc69d8a8ba97270eda146b23c1a9\", \"unit_tests\": \"de5f0d00b09b6e5226d5498542aa1745434d1c32\", \"url_unittests\": \"a36bf0f471ec21c9ce5719bb3d3bee1516acc535\", \"views_perftests\": \"11d42a567c0a5a0af39f58c3ecfa32a21298e4d2\", \"views_unittests\": \"d51f3b8aaef74565ff4dc8444834913e1d435e41\", \"viz_unittests\": \"e0ace031c6c6d5a3fe22e2294a5501a490e45d21\", \"vr_common_unittests\": \"b1bbd25890b116a0501d2de81a9045e3283a8382\", \"vr_pixeltests\": \"1b36460d6c0a67424a2236af27c9e29902e9320e\", \"webdriver_wpt_tests\": \"d1ea4a7e213c81a78ad4b7195abadd6c0c6566b8\", \"weblayer_browsertests\": \"ee475eca01994fca51f5bec7f71eef81456bffbf\", \"wm_unittests\": \"ba00745706847e6166e5b7eddae4a8f169123e0f\", \"wtf_unittests\": \"951e5c551367a72d7c4f2c6d724169aca1bf1678\", \"xr_browser_tests\": \"b823fbf832511b4b213855ce07a6e05e65a74bef\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_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-30-j5wr\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582100161323083",
"status": "COMPLETED",
"status_changed_ts": "1582103020920908",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168781",
"builder:Linux Builder (dbg)",
"buildset:commit/git/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/262a71bd3d3271cceb44c4e034efccc1bd3cb5a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053471776462331392",
"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/8888041713895635856/+/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:4a755271c1c6ce10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582103020924000",
"url": "https://ci.chromium.org/b/8888041713895635856",
"utcnow_ts": "1582103021566700"
}
}
[09:03:41.579] Invocation finished in 51m46.891587593s with status SUCCEEDED