[06:22:08.481] New invocation is queued and will start shortly
[06:22:09.957] Starting the invocation (attempt 1)
[06:22:09.991] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:22:09.991] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:22:09.991] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054203458348214128",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dcc125ad557b48573f5ef69ba5d2c3eb04485bdc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054203458348214128",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"gitiles_ref:refs/heads/master"
]
}
[06:22:11.263] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581402130469855",
"id": "8888773395599770256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dcc125ad557b48573f5ef69ba5d2c3eb04485bdc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581402131123490",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168474",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054203458348214128",
"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/8888773395599770256/+/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": "1581402131123771",
"url": "https://ci.chromium.org/b/8888773395599770256",
"utcnow_ts": "1581402131251671"
}
}
[06:22:11.263] Task URL: https://ci.chromium.org/b/8888773395599770256
[06:22:11.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:2:0) after 1m0s
[06:23:11.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:2:0)
[06:23:11.351] Timer tick, asking Buildbucket for the build status
[06:23:11.834] Build 8888773395599770256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:11.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:3:0) after 1m0s
[06:24:11.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:3:0)
[06:24:11.902] Timer tick, asking Buildbucket for the build status
[06:24:12.383] Build 8888773395599770256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:12.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:4:0) after 1m0s
[06:25:12.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:4:0)
[06:25:12.422] Timer tick, asking Buildbucket for the build status
[06:25:12.658] Build 8888773395599770256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:12.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:5:0) after 1m0s
[06:26:12.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:5:0)
[06:26:12.726] Timer tick, asking Buildbucket for the build status
[06:26:13.225] Build 8888773395599770256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:13.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:6:0) after 1m0s
[06:27:05.927] Received PubSub notification, asking Buildbucket for the build status
[06:27:06.509] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:13.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:6:0)
[06:27:13.213] Timer tick, asking Buildbucket for the build status
[06:27:13.360] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:8:0) after 1m0s
[06:28:13.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:8:0)
[06:28:13.517] Timer tick, asking Buildbucket for the build status
[06:28:13.695] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:13.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:9:0) after 1m0s
[06:29:13.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:9:0)
[06:29:13.721] Timer tick, asking Buildbucket for the build status
[06:29:13.907] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:13.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:10:0) after 1m0s
[06:30:14.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:10:0)
[06:30:14.034] Timer tick, asking Buildbucket for the build status
[06:30:14.214] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:11:0) after 1m0s
[06:31:14.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:11:0)
[06:31:14.229] Timer tick, asking Buildbucket for the build status
[06:31:14.408] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:14.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:12:0) after 1m0s
[06:32:14.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:12:0)
[06:32:14.522] Timer tick, asking Buildbucket for the build status
[06:32:14.674] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:14.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:13:0) after 1m0s
[06:33:14.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:13:0)
[06:33:14.695] Timer tick, asking Buildbucket for the build status
[06:33:15.011] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:15.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:14:0) after 1m0s
[06:34:15.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:14:0)
[06:34:15.067] Timer tick, asking Buildbucket for the build status
[06:34:15.269] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:15.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:15:0) after 1m0s
[06:35:15.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:15:0)
[06:35:15.307] Timer tick, asking Buildbucket for the build status
[06:35:16.198] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:16.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:16:0) after 1m0s
[06:36:16.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:16:0)
[06:36:16.235] Timer tick, asking Buildbucket for the build status
[06:36:17.064] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:17.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:17:0) after 1m0s
[06:37:17.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:17:0)
[06:37:17.124] Timer tick, asking Buildbucket for the build status
[06:37:17.274] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:17.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:18:0) after 1m0s
[06:38:17.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:18:0)
[06:38:17.331] Timer tick, asking Buildbucket for the build status
[06:38:17.499] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:17.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:19:0) after 1m0s
[06:39:17.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:19:0)
[06:39:17.523] Timer tick, asking Buildbucket for the build status
[06:39:18.865] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:18.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:20:0) after 1m0s
[06:40:18.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:20:0)
[06:40:18.955] Timer tick, asking Buildbucket for the build status
[06:40:19.174] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:21:0) after 1m0s
[06:41:19.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:21:0)
[06:41:19.239] Timer tick, asking Buildbucket for the build status
[06:41:19.451] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:19.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:22:0) after 1m0s
[06:42:19.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:22:0)
[06:42:19.440] Timer tick, asking Buildbucket for the build status
[06:42:20.323] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:20.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:23:0) after 1m0s
[06:43:20.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:23:0)
[06:43:20.312] Timer tick, asking Buildbucket for the build status
[06:43:20.551] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:20.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:24:0) after 1m0s
[06:44:20.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:24:0)
[06:44:20.573] Timer tick, asking Buildbucket for the build status
[06:44:21.165] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:21.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:25:0) after 1m0s
[06:45:21.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:25:0)
[06:45:21.187] Timer tick, asking Buildbucket for the build status
[06:45:21.851] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:21.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:26:0) after 1m0s
[06:46:21.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:26:0)
[06:46:21.864] Timer tick, asking Buildbucket for the build status
[06:46:22.099] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:22.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:27:0) after 1m0s
[06:47:22.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:27:0)
[06:47:22.131] Timer tick, asking Buildbucket for the build status
[06:47:22.403] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:22.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:28:0) after 1m0s
[06:48:22.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:28:0)
[06:48:22.420] Timer tick, asking Buildbucket for the build status
[06:48:22.566] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:22.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:29:0) after 1m0s
[06:49:22.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:29:0)
[06:49:22.618] Timer tick, asking Buildbucket for the build status
[06:49:23.228] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:23.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:30:0) after 1m0s
[06:50:23.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:30:0)
[06:50:23.241] Timer tick, asking Buildbucket for the build status
[06:50:23.553] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:23.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:31:0) after 1m0s
[06:51:23.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:31:0)
[06:51:23.610] Timer tick, asking Buildbucket for the build status
[06:51:24.293] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:24.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:32:0) after 1m0s
[06:52:24.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:32:0)
[06:52:24.301] Timer tick, asking Buildbucket for the build status
[06:52:25.525] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:25.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:33:0) after 1m0s
[06:53:25.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:33:0)
[06:53:25.532] Timer tick, asking Buildbucket for the build status
[06:53:25.708] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:25.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:34:0) after 1m0s
[06:54:25.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:34:0)
[06:54:25.732] Timer tick, asking Buildbucket for the build status
[06:54:25.872] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:25.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:35:0) after 1m0s
[06:55:25.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:35:0)
[06:55:25.898] Timer tick, asking Buildbucket for the build status
[06:55:26.033] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:36:0) after 1m0s
[06:56:26.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:36:0)
[06:56:26.168] Timer tick, asking Buildbucket for the build status
[06:56:26.842] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:26.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:37:0) after 1m0s
[06:57:26.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:37:0)
[06:57:26.893] Timer tick, asking Buildbucket for the build status
[06:57:27.041] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:27.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:38:0) after 1m0s
[06:58:27.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:38:0)
[06:58:27.081] Timer tick, asking Buildbucket for the build status
[06:58:27.220] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:27.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:39:0) after 1m0s
[06:59:27.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:39:0)
[06:59:27.412] Timer tick, asking Buildbucket for the build status
[06:59:27.583] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:27.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:40:0) after 1m0s
[07:00:27.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:40:0)
[07:00:27.631] Timer tick, asking Buildbucket for the build status
[07:00:27.793] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:27.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:41:0) after 1m0s
[07:01:27.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:41:0)
[07:01:27.946] Timer tick, asking Buildbucket for the build status
[07:01:28.119] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:28.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:42:0) after 1m0s
[07:02:28.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:42:0)
[07:02:28.263] Timer tick, asking Buildbucket for the build status
[07:02:28.421] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:28.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:43:0) after 1m0s
[07:03:28.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:43:0)
[07:03:28.456] Timer tick, asking Buildbucket for the build status
[07:03:28.598] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:28.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:44:0) after 1m0s
[07:04:28.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:44:0)
[07:04:28.719] Timer tick, asking Buildbucket for the build status
[07:04:29.342] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:29.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:45:0) after 1m0s
[07:05:29.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:45:0)
[07:05:29.502] Timer tick, asking Buildbucket for the build status
[07:05:29.638] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:29.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:46:0) after 1m0s
[07:06:29.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:46:0)
[07:06:29.683] Timer tick, asking Buildbucket for the build status
[07:06:29.895] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:29.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:47:0) after 1m0s
[07:07:29.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:47:0)
[07:07:29.903] Timer tick, asking Buildbucket for the build status
[07:07:30.107] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:30.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:48:0) after 1m0s
[07:08:30.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:48:0)
[07:08:30.181] Timer tick, asking Buildbucket for the build status
[07:08:30.414] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:30.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:49:0) after 1m0s
[07:09:30.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:49:0)
[07:09:30.657] Timer tick, asking Buildbucket for the build status
[07:09:31.188] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:31.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:50:0) after 1m0s
[07:10:31.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:50:0)
[07:10:31.241] Timer tick, asking Buildbucket for the build status
[07:10:32.088] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:32.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:51:0) after 1m0s
[07:11:32.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:51:0)
[07:11:32.150] Timer tick, asking Buildbucket for the build status
[07:11:32.468] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:32.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:52:0) after 1m0s
[07:12:32.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:52:0)
[07:12:32.635] Timer tick, asking Buildbucket for the build status
[07:12:33.332] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:33.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:53:0) after 1m0s
[07:13:33.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:53:0)
[07:13:33.381] Timer tick, asking Buildbucket for the build status
[07:13:33.519] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:54:0) after 1m0s
[07:14:33.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:54:0)
[07:14:33.578] Timer tick, asking Buildbucket for the build status
[07:14:33.792] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:33.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:55:0) after 1m0s
[07:15:33.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:55:0)
[07:15:33.836] Timer tick, asking Buildbucket for the build status
[07:15:34.229] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:34.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:56:0) after 1m0s
[07:16:34.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:56:0)
[07:16:34.276] Timer tick, asking Buildbucket for the build status
[07:16:37.140] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:37.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:57:0) after 1m0s
[07:17:37.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:57:0)
[07:17:37.463] Timer tick, asking Buildbucket for the build status
[07:17:37.660] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:37.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:58:0) after 1m0s
[07:18:37.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:58:0)
[07:18:37.736] Timer tick, asking Buildbucket for the build status
[07:18:38.212] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:38.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:59:0) after 1m0s
[07:19:38.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:59:0)
[07:19:38.367] Timer tick, asking Buildbucket for the build status
[07:19:39.281] Build 8888773395599770256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:39.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054203458348214128:60:0) after 1m0s
[07:20:16.477] Received PubSub notification, asking Buildbucket for the build status
[07:20:17.267] Build 8888773395599770256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:20:17.267] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581405615492519",
"created_by": "project:chromium",
"created_ts": "1581402130469855",
"id": "8888773395599770256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dcc125ad557b48573f5ef69ba5d2c3eb04485bdc\"}}",
"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-136-lp80\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168474, \"got_angle_revision\": \"b40d48a67c932625f349c6e58036c2d96b62489b\", \"got_dawn_revision\": \"713d9cbf939e525e025a69a17bda0bf51b449c47\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"dcc125ad557b48573f5ef69ba5d2c3eb04485bdc\", \"got_revision_cp\": \"refs/heads/master@{#740199}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"196d81774ef86d1c6c2d028dd5407b47eaa51a99\", \"got_v8_revision\": \"d0da7b4db4d335d91a374ec3be53199c482e7174\", \"got_v8_revision_cp\": \"refs/heads/8.2.56@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dcc125ad557b48573f5ef69ba5d2c3eb04485bdc\", \"swarm_hashes_refs/heads/master(at){#740199}_without_patch\": {\"accessibility_unittests\": \"e3bf8d98edb377e995203a5f1ec2682ebfa6bfbe\", \"angle_unittests\": \"45d49712fb055a6351f209eeb3aeb298900ed9ac\", \"app_shell_unittests\": \"21d69e55450b2eaa7b719296658301183918e949\", \"aura_unittests\": \"f899690065aff9a16bd2ba22479fee1c715be1a3\", \"base_unittests\": \"c1cf812a1a28741f61a986d5e30887046734d2d9\", \"base_util_unittests\": \"c05025d6be5cb337a3dbd3063e68ed2a1628689d\", \"blink_common_unittests\": \"81d3b7588a6ace9b0e7ef8db956eda1ddb62908f\", \"blink_fuzzer_unittests\": \"f5fbfb380f414d6ea146aafe68ecbd7f06dbe49d\", \"blink_heap_unittests\": \"c1dd3aa2c31d9f5b7f36ba2ae7310a3d730cac1a\", \"blink_platform_unittests\": \"b591f3d5616f175be28b849f993af85e219a9482\", \"blink_python_tests\": \"7f761899a775c918b692ac256b818601626e2015\", \"blink_unittests\": \"d30108c87e432c324695e98030f850d3501216d2\", \"blink_web_tests\": \"3dc15999a96b3ed141682ef7bf9545821111bfa8\", \"boringssl_crypto_tests\": \"95e11b3ad1485ef5ca655ac0b86d8ff3dba78047\", \"boringssl_ssl_tests\": \"8866b6c4ad6d38ade44b9b37bae3ea235aadd8cc\", \"browser_tests\": \"ee842e803b156b30d763331b02b66c0519cd5984\", \"cacheinvalidation_unittests\": \"1d10521a9370a4731b63a49784b78475af69f943\", \"capture_unittests\": \"b90ff7a6a259fd0f9617cc0e0605fa0514f7164e\", \"cast_unittests\": \"87264e0b66f48bf35e39d2a54082c77e03109bd8\", \"cc_unittests\": \"3e7c232b680eb60a51e01c9bd04d4ecae5372aa8\", \"chrome_app_unittests\": \"1f68e1f93adb6b6b6583abac3eed9ef1c63c6099\", \"chromedriver_unittests\": \"d53eb1a315cd85b4584e9d639a6900e7a04d5ca2\", \"components_browsertests\": \"ffe378044d314a814e9fce3fed950cf4e944b54e\", \"components_unittests\": \"78f143b6a786d4d4cd7df555e87af7aa087d2017\", \"compositor_unittests\": \"e3038381a187e5da3aafab225560e5deb2f621cf\", \"content_browsertests\": \"0d8ef37efcabc678cf975b40a88a4a12957c9631\", \"content_shell_crash_test\": \"951cbd1746672b2eac866ef76aa06fc49c733241\", \"content_unittests\": \"8aae81e972f0886b9a07ea667742dfcfda6d259f\", \"crashpad_tests\": \"023803b06a5c1d9219866baadc639dd403479e66\", \"cronet_tests\": \"afb8d372033c3310d8645806fbb59e3891e9d745\", \"cronet_unittests\": \"e60d6dd46ec7f77542bdeb7da2245e53abe6d039\", \"crypto_unittests\": \"d22b6be1d474b603123318a330a4f75492406c0b\", \"dbus_unittests\": \"c6c5b33b5c4c1bd03bc012e23724f7a0b2e043ce\", \"device_unittests\": \"c8b582cea6b628c5353db93b211d1215276901b0\", \"display_unittests\": \"6c6c7c37cdd8d4e0965b1789fa15529d12919202\", \"events_unittests\": \"190220a0b2d773943eae2359d07d811f6ba379af\", \"extensions_browsertests\": \"00d97341fee3d7715212a0113158a875909ffb0c\", \"extensions_unittests\": \"3ff44f2db5025f18925f8306cf367d4c6c195bfb\", \"filesystem_service_unittests\": \"3d6a8fd75ea261b00a21ca9b3fae8c996ef395ee\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"95239d65207789808582c2dfc37c16b606a3106c\", \"gfx_unittests\": \"4e548a6f4370c097f67567226f7b3e38fe351cfe\", \"gin_unittests\": \"660e6221e90e5b24fdfd4797224b2ccce057d423\", \"google_apis_unittests\": \"343b19247d40a8bf0e398a65a4ce859f70bd068f\", \"gpu_unittests\": \"56456f4d6c4d459f6c5f572b3282642bad7f3239\", \"grit_python_unittests\": \"2c197a1bd065e31b00ed1c7636679f90a901aabe\", \"gwp_asan_unittests\": \"6fba2dccc1827b6afc3e6376d168a769b8d93843\", \"headless_browsertests\": \"85b9383b9d696f9ccf1f3658a4edf3f27cfc7b70\", \"headless_unittests\": \"05af86e9a973279ffe6362651c9fac0ae2eafec7\", \"interactive_ui_tests\": \"ebff64b741d3ea6594e959319c5f665895d51fee\", \"ipc_tests\": \"765ed4f09167612a2b6ae48c43e94f4a7af8ac42\", \"jingle_unittests\": \"bcb373c108e059a562abdebb6a3373e12421aeac\", \"latency_unittests\": \"a578c8b583900eaf1cf270847959d9e9f548772b\", \"libjingle_xmpp_unittests\": \"e9a128a14f8c998fe9e82a43f7418dafac36e1a3\", \"media_blink_unittests\": \"57b75526e95c234dd7cd65c6b8db4d0f7162ecf4\", \"media_service_unittests\": \"0fe504384596c704f98f4834f484d7ae2148ae63\", \"media_unittests\": \"fbe0eed00268c4f7929bb0d82982bb89c3a5ff49\", \"message_center_unittests\": \"e8add62e1031cd8706b2453b7aac00976b64377b\", \"metrics_python_tests\": \"045c971a5da077626561c542839b047d935a0b97\", \"midi_unittests\": \"6a2efd20b2ef6d361bd28f3bd66f0e0d587cd7f3\", \"mojo_core_unittests\": \"f88b9a3addfffc8a12d94a8ed58ea0f43f9a433a\", \"mojo_unittests\": \"c9a22c2495e9602ea7a08938968be34237060619\", \"nacl_helper_nonsfi_unittests\": \"2ebd60291f651fd7b65f4c47daa251c4ae4148b0\", \"nacl_loader_unittests\": \"ba621714135edceb6f5529ffa6d583643b0d20f6\", \"native_theme_unittests\": \"9f539cafe7d6336ae6f2b71af1856e37bb964aec\", \"net_unittests\": \"c41696d785b8ec90beb4a9930279d47a649ec7bc\", \"pdf_unittests\": \"2b8f01424e2d63e2b911fc195cdff4bf5c67bde5\", \"perfetto_unittests\": \"3ee544ec1f12955df0e818e3bb6a4ee4e63f4805\", \"ppapi_unittests\": \"c286ad2223c7b03ddaa9f7e3829bab6136f5197c\", \"printing_unittests\": \"90dc6a6d8c0782966faeee11cad9f4ab4b22c65a\", \"remoting_unittests\": \"e2bfca0ca4e3ef8918387e7350501f5e0df64ad1\", \"sandbox_linux_unittests\": \"e8d4ed764c6c7c4768ad6000eb2e73ddb502bc6a\", \"service_manager_unittests\": \"40a4b1022bb4d953a460c07e91c588fe69340fe7\", \"services_unittests\": \"4e474a33027445e26c13e3119f37724c04481e1d\", \"shell_dialogs_unittests\": \"e276c6f9a4fabb87dbeca231ff2451b83535206b\", \"skia_unittests\": \"054fe84a04d8f6028a06546318ff90eaf020b318\", \"snapshot_unittests\": \"65e0a5b10599fd0e85bca6e93db7ee08d16de310\", \"sql_unittests\": \"1d3e703df90a5bbda98999360d9009e9aefeebd2\", \"storage_unittests\": \"1ec1ea02a316d2ed911979b77b340c5bd33907b8\", \"sync_integration_tests\": \"800127ed55b3f3f524587f0f848eb59254a7f80f\", \"telemetry_gpu_unittests\": \"33d01b4932208cc1b8f155b0983a9ee788420ba1\", \"telemetry_perf_unittests\": \"aa2698229deb067a632605612753daee94e72f93\", \"telemetry_unittests\": \"38da78569bca33f7e61e292bd7f5dd0c5da34d8e\", \"traffic_annotation_auditor_unittests\": \"e5d92524611892f7593cc41a33435f7b10b6b859\", \"ui_base_unittests\": \"1221a0f899011ea3b6a3b32f963347416caad307\", \"ui_touch_selection_unittests\": \"283156e61dd6e99b9ed0204df5d5689e941f52ed\", \"unit_tests\": \"eb99d0efae72ddc5e83baeaf5abd4b68ce36b614\", \"url_unittests\": \"49f2783dcb6b3311e0355455f39271753b48522a\", \"views_perftests\": \"703aedc0a7dcec92d4aa48a0efccd8a049ac872a\", \"views_unittests\": \"61ad0f005cf8f1adb99db42fc91183645b875db6\", \"viz_unittests\": \"618d90eee1a381457ff57ed8fda0e85485a02af5\", \"vr_common_unittests\": \"0d84295d22aae4ac5a202e9ce84948d5f1550860\", \"vr_pixeltests\": \"bc3740cff7f3538af1a46642350cb99bc739102f\", \"webdriver_wpt_tests\": \"75399adc03f6a6efbcf2da423c8208243cfb556a\", \"weblayer_browsertests\": \"e81ec431e3094294e8bf8722479756b949e47eeb\", \"wm_unittests\": \"fe26b52437390689179caf37cfaddec8cd288d25\", \"wtf_unittests\": \"e341a1c333ad2ff10c44c657438eb769f2914811\", \"xr_browser_tests\": \"4969814fab3dd6783660e99b0717592e2db32f2c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_bdaf1433b62bd3619468ac2d2b745ba32f34c58221b7630e6cf9dedcc4b44d8b_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_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-136-lp80\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581402425099060",
"status": "COMPLETED",
"status_changed_ts": "1581405615720752",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168474",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dcc125ad557b48573f5ef69ba5d2c3eb04485bdc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054203458348214128",
"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/8888773395599770256/+/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:4a4bbb1426416410",
"user_agent:luci-scheduler"
],
"updated_ts": "1581405615743651",
"url": "https://ci.chromium.org/b/8888773395599770256",
"utcnow_ts": "1581405617208105"
}
}
[07:20:17.267] Invocation finished in 58m8.802933443s with status SUCCEEDED