[05:13:36.397] New invocation is queued and will start shortly
[05:13:37.521] Starting the invocation (attempt 1)
[05:13:37.551] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:13:37.553] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:13:37.553] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023042413737259792",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9023042413737259792",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"gitiles_ref:refs/heads/master"
]
}
[05:13:38.455] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611119617631794",
"id": "8857612351781068656",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611119618269132",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179807",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023042413737259792",
"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/8857612351781068656/+/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": "1611119618269247",
"url": "https://ci.chromium.org/b/8857612351781068656",
"utcnow_ts": "1611119618439861"
}
}
[05:13:38.455] Task URL: https://ci.chromium.org/b/8857612351781068656
[05:13:38.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:2:0) after 1m0s
[05:13:39.794] Received PubSub notification, asking Buildbucket for the build status
[05:13:40.029] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:2:0)
[05:14:38.507] Timer tick, asking Buildbucket for the build status
[05:14:38.607] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:4:0) after 1m0s
[05:15:38.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:4:0)
[05:15:38.624] Timer tick, asking Buildbucket for the build status
[05:15:38.675] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:38.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:5:0) after 1m0s
[05:16:38.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:5:0)
[05:16:38.746] Timer tick, asking Buildbucket for the build status
[05:16:38.926] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:38.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:6:0) after 1m0s
[05:17:39.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:6:0)
[05:17:39.021] Timer tick, asking Buildbucket for the build status
[05:17:39.125] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:39.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:7:0) after 1m0s
[05:18:39.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:7:0)
[05:18:39.142] Timer tick, asking Buildbucket for the build status
[05:18:39.551] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:39.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:8:0) after 1m0s
[05:19:39.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:8:0)
[05:19:39.576] Timer tick, asking Buildbucket for the build status
[05:19:39.704] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:9:0) after 1m0s
[05:20:39.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:9:0)
[05:20:39.793] Timer tick, asking Buildbucket for the build status
[05:20:39.856] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:39.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:10:0) after 1m0s
[05:21:39.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:10:0)
[05:21:39.908] Timer tick, asking Buildbucket for the build status
[05:21:40.059] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:40.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:11:0) after 1m0s
[05:22:40.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:11:0)
[05:22:40.164] Timer tick, asking Buildbucket for the build status
[05:22:40.417] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:40.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:12:0) after 1m0s
[05:23:40.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:12:0)
[05:23:40.458] Timer tick, asking Buildbucket for the build status
[05:23:40.554] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:40.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:13:0) after 1m0s
[05:24:40.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:13:0)
[05:24:40.538] Timer tick, asking Buildbucket for the build status
[05:24:40.647] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:40.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:14:0) after 1m0s
[05:25:40.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:14:0)
[05:25:40.715] Timer tick, asking Buildbucket for the build status
[05:25:40.774] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:40.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:15:0) after 1m0s
[05:26:40.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:15:0)
[05:26:40.830] Timer tick, asking Buildbucket for the build status
[05:26:40.971] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:40.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:16:0) after 1m0s
[05:27:41.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:16:0)
[05:27:41.023] Timer tick, asking Buildbucket for the build status
[05:27:41.082] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:17:0) after 1m0s
[05:28:41.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:17:0)
[05:28:41.062] Timer tick, asking Buildbucket for the build status
[05:28:41.324] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:18:0) after 1m0s
[05:29:41.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:18:0)
[05:29:41.352] Timer tick, asking Buildbucket for the build status
[05:29:41.421] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:41.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:19:0) after 1m0s
[05:30:41.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:19:0)
[05:30:41.477] Timer tick, asking Buildbucket for the build status
[05:30:41.615] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:41.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:20:0) after 1m0s
[05:31:41.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:20:0)
[05:31:41.694] Timer tick, asking Buildbucket for the build status
[05:31:41.760] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:41.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:21:0) after 1m0s
[05:32:41.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:21:0)
[05:32:41.778] Timer tick, asking Buildbucket for the build status
[05:32:41.842] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:41.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:22:0) after 1m0s
[05:33:41.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:22:0)
[05:33:41.869] Timer tick, asking Buildbucket for the build status
[05:33:42.073] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:42.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:23:0) after 1m0s
[05:34:42.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:23:0)
[05:34:42.059] Timer tick, asking Buildbucket for the build status
[05:34:42.397] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:42.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:24:0) after 1m0s
[05:35:42.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:24:0)
[05:35:42.417] Timer tick, asking Buildbucket for the build status
[05:35:42.494] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:42.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:25:0) after 1m0s
[05:36:42.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:25:0)
[05:36:42.514] Timer tick, asking Buildbucket for the build status
[05:36:42.629] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:42.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:26:0) after 1m0s
[05:37:42.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:26:0)
[05:37:42.663] Timer tick, asking Buildbucket for the build status
[05:37:42.724] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:42.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:27:0) after 1m0s
[05:38:42.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:27:0)
[05:38:42.777] Timer tick, asking Buildbucket for the build status
[05:38:42.930] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:42.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:28:0) after 1m0s
[05:39:43.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:28:0)
[05:39:43.002] Timer tick, asking Buildbucket for the build status
[05:39:43.062] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:43.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:29:0) after 1m0s
[05:40:43.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:29:0)
[05:40:43.087] Timer tick, asking Buildbucket for the build status
[05:40:43.173] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:43.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:30:0) after 1m0s
[05:41:43.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:30:0)
[05:41:43.205] Timer tick, asking Buildbucket for the build status
[05:41:43.295] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:43.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:31:0) after 1m0s
[05:42:43.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:31:0)
[05:42:43.294] Timer tick, asking Buildbucket for the build status
[05:42:43.455] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:43.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:32:0) after 1m0s
[05:43:43.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:32:0)
[05:43:43.443] Timer tick, asking Buildbucket for the build status
[05:43:43.544] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:43.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:33:0) after 1m0s
[05:44:43.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:33:0)
[05:44:43.652] Timer tick, asking Buildbucket for the build status
[05:44:43.988] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:43.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:34:0) after 1m0s
[05:45:44.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:34:0)
[05:45:44.054] Timer tick, asking Buildbucket for the build status
[05:45:44.130] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:44.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:35:0) after 1m0s
[05:46:44.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:35:0)
[05:46:44.273] Timer tick, asking Buildbucket for the build status
[05:46:44.365] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:44.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:36:0) after 1m0s
[05:47:44.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:36:0)
[05:47:44.395] Timer tick, asking Buildbucket for the build status
[05:47:44.451] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:44.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:37:0) after 1m0s
[05:48:44.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:37:0)
[05:48:44.525] Timer tick, asking Buildbucket for the build status
[05:48:44.613] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:44.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:38:0) after 1m0s
[05:49:44.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:38:0)
[05:49:44.695] Timer tick, asking Buildbucket for the build status
[05:49:44.754] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:39:0) after 1m0s
[05:50:44.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:39:0)
[05:50:44.815] Timer tick, asking Buildbucket for the build status
[05:50:44.925] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:44.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:40:0) after 1m0s
[05:51:44.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:40:0)
[05:51:44.944] Timer tick, asking Buildbucket for the build status
[05:51:45.061] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:45.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:41:0) after 1m0s
[05:52:45.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:41:0)
[05:52:45.085] Timer tick, asking Buildbucket for the build status
[05:52:45.289] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:45.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:42:0) after 1m0s
[05:53:45.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:42:0)
[05:53:45.362] Timer tick, asking Buildbucket for the build status
[05:53:45.495] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:45.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:43:0) after 1m0s
[05:54:45.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:43:0)
[05:54:45.560] Timer tick, asking Buildbucket for the build status
[05:54:45.717] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:45.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:44:0) after 1m0s
[05:55:45.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:44:0)
[05:55:45.837] Timer tick, asking Buildbucket for the build status
[05:55:45.917] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:45.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:45:0) after 1m0s
[05:56:45.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:45:0)
[05:56:45.936] Timer tick, asking Buildbucket for the build status
[05:56:46.297] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:46.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:46:0) after 1m0s
[05:57:46.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:46:0)
[05:57:46.348] Timer tick, asking Buildbucket for the build status
[05:57:46.499] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:46.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:47:0) after 1m0s
[05:58:46.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:47:0)
[05:58:46.548] Timer tick, asking Buildbucket for the build status
[05:58:46.664] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:46.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:48:0) after 1m0s
[05:59:46.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:48:0)
[05:59:46.719] Timer tick, asking Buildbucket for the build status
[05:59:46.871] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:46.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:49:0) after 1m0s
[06:00:46.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:49:0)
[06:00:46.924] Timer tick, asking Buildbucket for the build status
[06:00:48.108] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:50:0) after 1m0s
[06:01:48.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:50:0)
[06:01:48.369] Timer tick, asking Buildbucket for the build status
[06:01:48.533] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:48.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:51:0) after 1m0s
[06:02:48.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:51:0)
[06:02:48.566] Timer tick, asking Buildbucket for the build status
[06:02:48.834] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:48.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:52:0) after 1m0s
[06:03:48.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:52:0)
[06:03:48.853] Timer tick, asking Buildbucket for the build status
[06:03:49.929] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:53:0) after 1m0s
[06:04:49.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:53:0)
[06:04:49.977] Timer tick, asking Buildbucket for the build status
[06:04:50.036] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:50.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:54:0) after 1m0s
[06:05:50.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:54:0)
[06:05:50.067] Timer tick, asking Buildbucket for the build status
[06:05:50.234] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:55:0) after 1m0s
[06:06:50.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:55:0)
[06:06:50.283] Timer tick, asking Buildbucket for the build status
[06:06:50.513] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:50.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:56:0) after 1m0s
[06:07:50.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:56:0)
[06:07:50.516] Timer tick, asking Buildbucket for the build status
[06:07:50.625] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:50.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:57:0) after 1m0s
[06:08:50.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:57:0)
[06:08:50.711] Timer tick, asking Buildbucket for the build status
[06:08:51.182] Build 8857612351781068656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:51.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023042413737259792:58:0) after 1m0s
[06:09:25.209] Received PubSub notification, asking Buildbucket for the build status
[06:09:25.310] Build 8857612351781068656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:09:25.310] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611122964294895",
"created_by": "project:chromium",
"created_ts": "1611119617631794",
"id": "8857612351781068656",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-7-9srv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179807, \"got_angle_revision\": \"2e0490eedcc809bcd6359de6afdb9e40bd9f731a\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\", \"got_revision_cp\": \"refs/heads/master@{#845015}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"89fd1480b47e8c8668dfd3c24302c53b76ba4c88\", \"got_v8_revision\": \"69c461e9bd40c5c45d553d3d19bb2771e32b4d64\", \"got_v8_revision_cp\": \"refs/heads/9.0.18@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\", \"swarm_hashes_refs/heads/master(at){#845015}_without_patch\": {\"absl_hardening_tests\": \"019442d912c90a80210589b6385777a7ffd63c7e\", \"accessibility_unittests\": \"b864a2e8820b144861b5e6edbec190da3b2472fa\", \"angle_unittests\": \"c70158c46640df6ca0dad7fb1845b2642e7e48d2\", \"app_shell_unittests\": \"9220bb2bb6ac9f3823652a57d263dd4b5e211292\", \"aura_unittests\": \"f3706f08b989d48035d82efc7428655d17e89850\", \"base_unittests\": \"da9fbc5a9c375e067936b254152ae9fa502a53df\", \"base_util_unittests\": \"798ff05bb356e5acce1bd20da13bf6becce849c2\", \"blink_common_unittests\": \"6b2fc470cef420bf127f1405bc82ab883ec54a61\", \"blink_fuzzer_unittests\": \"823261e54a4974584c47b2acf9c7e7fc8f469b62\", \"blink_heap_unittests\": \"feb55a089fd59af14dc83c9c427764fee854b7f5\", \"blink_platform_unittests\": \"d357252edbfce2b15ca0a60298197207bc0553f0\", \"blink_python_tests\": \"d7e13cf32a2851697535d3574fc892a58c14efff\", \"blink_unittests\": \"40ae023423eb1510412c22423e8054e81ff66aa7\", \"blink_web_tests\": \"e4f52f6b2839e0e530153deff465099abe2c1393\", \"boringssl_crypto_tests\": \"fe6968af961712990731e5948fc447e7e511d3c3\", \"boringssl_ssl_tests\": \"ac629864d8b4c7bf8fec0954e1b7c6fe0ad16cc2\", \"browser_tests\": \"62c3d36a595b072c73e61ed8068e0b5a86785d12\", \"capture_unittests\": \"e274029fe8bcea1e49933cdabc9ea80901d5ef62\", \"cast_unittests\": \"4437cb8beaa6f6624801c9cab76cc3cc4ed653ac\", \"cc_unittests\": \"84f0062929bd50d13d0f501efc2b76e55848a186\", \"chrome_app_unittests\": \"cd6a4c3adb26744c75315492b6ee201c12c23d0e\", \"chromedriver_unittests\": \"949f26fd15673ac73ba5b8fdc9361a13e45ff56e\", \"components_browsertests\": \"075bfb5d9d88ccb6e195e54619aee619f2a0daa6\", \"components_unittests\": \"aa64e47e1532f869a81e9199e0b1ad9e7b0a6020\", \"compositor_unittests\": \"0394044fd0c76e79206701221586f6cb1ae91388\", \"content_browsertests\": \"3bdc46f157adb6ebfe84c9b247dfe2b41ea8526d\", \"content_shell_crash_test\": \"4c5a7ff32b72784db240c0a0740f236ef4d86332\", \"content_unittests\": \"f7724a120981c50d95d49b6b7ee7cef148b6fddf\", \"crashpad_tests\": \"9a43236d1d1a933a02413647cdad5f6be319a639\", \"cronet_tests\": \"338305bb4eff9186152308f9c33ac8599b410097\", \"cronet_unittests\": \"7cb41dd434431ad2997f2d6685a10fe79d96d63b\", \"crypto_unittests\": \"cdf95dbc0ab8070b652addfecf6b699e876b6ea1\", \"dbus_unittests\": \"e29b44b7c1b2ece3da21c7f651f3259b76153381\", \"device_unittests\": \"a77596b0465f7475b1aa3efba1aa2e3dc40cd7dd\", \"display_unittests\": \"211ab6b547bc26dcf02e7673f14144ddd0ba2b0b\", \"events_unittests\": \"fbe1582dac3c194fa730a2be873f70dd36a7c230\", \"extensions_browsertests\": \"f1b7d7c18a1fa02a68cd924199d6dd72a41a248f\", \"extensions_unittests\": \"365d7f1a96e9ad531fc6d453d46bb812e9939512\", \"filesystem_service_unittests\": \"573f881fe112bb49c92e9df50945262ed61aad27\", \"flatbuffers_unittests\": \"6c3dbe15c318045b3d96cb08fc2d51ff0e14e495\", \"gcm_unit_tests\": \"3d816dbf91da6137691fc25de4393279ca8d1a98\", \"gfx_unittests\": \"01ca74d14d8c6e8d08c4b975b6dcf494f3d7abdf\", \"gin_unittests\": \"228012454dbc7e53d2d2f39b994e2d62c86d00c3\", \"google_apis_unittests\": \"ae1bdf74c5680f6e250dcd30899b87f9e2df4a87\", \"gpu_unittests\": \"af6fc3c822e0e82cf984fcf4d0366a01d52b9aa9\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"e86c3486d7c78d83d1cda25c5b6d27c5bd9ccc8c\", \"headless_browsertests\": \"39321e73b865e5fc554c58f69c215a15f74cd459\", \"headless_unittests\": \"d625e0e1aab9e9f84f8e5670779af5bb53d8fb4c\", \"interactive_ui_tests\": \"d922ab01cbee5ad68ef9b1a56e42d11475068a50\", \"ipc_tests\": \"39f73ec68532ba5fd41fc4979d6327a38e8b69a7\", \"jingle_unittests\": \"d8367ef89e1bbde2fb7051619c29e239bc54f230\", \"latency_unittests\": \"5b9ec50ad7dffe8b7dc9b6d76faf5ca28f0cfb68\", \"libjingle_xmpp_unittests\": \"74d1abafe68dbaf897ffc4f108951578a7a9519f\", \"liburlpattern_unittests\": \"7da77d574ebcb8e66c3814e1226d9809477b8eee\", \"media_blink_unittests\": \"2e7659f2bd07c8dab92037a6ed4db0a0f7b38fd1\", \"media_unittests\": \"d65300ebdc1d0f39cf124cd060d1323599ec9e2a\", \"message_center_unittests\": \"389a5f38959dbf888e3d45649bdbc329fa2c20de\", \"metrics_python_tests\": \"e66393a5f3ed63fffe356a72e21ff0458941486e\", \"midi_unittests\": \"50f09fb3bede3a21f33d3035aced31e272e9bcf9\", \"mojo_core_unittests\": \"826870a69288432737358eed00ef958d784917d3\", \"mojo_unittests\": \"bbb5bb9934ed4f082a46f22959307a322e448464\", \"nacl_helper_nonsfi_unittests\": \"3143bde62aad9452f0f31cb4ef8d16dee6c59e83\", \"nacl_loader_unittests\": \"f60d20f7d779e56913f8e1cdea02be18b66407cb\", \"native_theme_unittests\": \"c9aae102ae4638cc5095494f9184e8062cbc46ab\", \"net_unittests\": \"ee60deba77fa686f8cb75f8abc281897dadf656f\", \"openscreen_unittests\": \"68ed6e53ea64d74087c136163a4225fbd5661e2d\", \"pdf_unittests\": \"747011de40fd63d22b9a1274bf7f24c17d2266cc\", \"perfetto_unittests\": \"cb031bc5fb34d9031f90c762aee77f44d9f47cd5\", \"ppapi_unittests\": \"a88bfe363b21b7fcaa6cb3199e5dd7aef069dc07\", \"printing_unittests\": \"4bb39895fe6be0db14c014999af27d0d1a6a3965\", \"remoting_unittests\": \"42510c0d90db5c3611b8d683c9e2ebac5f51aa99\", \"sandbox_linux_unittests\": \"9c7eed855c950ad43aaae0f49e426ef11d546f81\", \"service_manager_unittests\": \"a171c959833d19433972f6b39e198b89d1323c78\", \"services_unittests\": \"6e423d2b999d3472f10308372581012e0ada4ac7\", \"shell_dialogs_unittests\": \"29f60467f12b3f881cfda076a4b1fe85823fde0a\", \"skia_unittests\": \"24da4923ee68a6672fcaad2d6906bf79544d58f5\", \"snapshot_unittests\": \"317910c4d587868a155dc32c5fe80ed00e7cddf4\", \"sql_unittests\": \"448b0a7c1738c5b2be357d5b6b5f8b67fe36dc90\", \"storage_unittests\": \"b05e287468d4af732e926855e4b0497f0a6e01c9\", \"sync_integration_tests\": \"180e1ff852429cbe6c5f35fb5e05d6d5aaff47d9\", \"telemetry_gpu_unittests\": \"b8c31b93ffdbf30ce549f72de390496d8755ffdf\", \"telemetry_perf_unittests\": \"585879e1a7dde8113cd936e33a1a8d0dea75d953\", \"telemetry_unittests\": \"5c7f7354a45874f7118f32f3b0a2663559486e11\", \"traffic_annotation_auditor_unittests\": \"f0da5d872f53d912c82f97b84106d438a8412120\", \"ui_base_unittests\": \"3211ed2c8608501beb7f26d21c5cd293cb282a42\", \"ui_touch_selection_unittests\": \"ae18353e080c9b5fcf0b877bbddf6d5d11049f25\", \"unit_tests\": \"882b7d24f3b7ef8ea22c55f71098b770f7fecd06\", \"url_unittests\": \"77673f07a5a5912a5bc488be33b93edf454abde0\", \"views_perftests\": \"e4bbbc18b8bdc84542d0865a78cc78c7106bdbf7\", \"views_unittests\": \"3da0c6857a452056c79289046c27635936fdf742\", \"viz_unittests\": \"1558edcec8ee57578b5721334cfe888d5017d8e0\", \"vr_common_unittests\": \"c65b81ecac947ebc988dc71b8b94f19a32af9a33\", \"vr_pixeltests\": \"353b5692e20a6df191956bdf3af08154aa6e65a8\", \"webdriver_wpt_tests\": \"eebb627881cbe8a20c392ad5b64998703a11e88e\", \"weblayer_browsertests\": \"b944d2f9e1400cb2fda6a13793b059421808a51b\", \"weblayer_unittests\": \"e3c078e6ab9af86b3449a3a8c767f43d81c51340\", \"wm_unittests\": \"a3183cb81abb96205fb0708de871d62f78e7368e\", \"wtf_unittests\": \"2f739e1d34ab9b25cb7903fe84630434fd21e414\", \"x11_unittests\": \"0f7c3b7b1a54f50ea03e46610d6d95c0eaa2a1fb\", \"xr_browser_tests\": \"d70c031f08df8608c63cd555466380e1676e669e\", \"zlib_unittests\": \"94e11197073ea2be173949f3733a740cfb1a1c8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_a1c3d05f1886c3c1a4b693e8245da857a9c63a0cda58ad280c9a386162f50760_v2\", \"builder_ce300ca2149b7ede2a11dc5f29b170d3e5c2bdd2b201177604ba7c6bb221adeb_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-7-9srv\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611119619050427",
"status": "COMPLETED",
"status_changed_ts": "1611122964835386",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179807",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023042413737259792",
"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/8857612351781068656/+/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:513707f217171210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611122964840104",
"url": "https://ci.chromium.org/b/8857612351781068656",
"utcnow_ts": "1611122965300458"
}
}
[06:09:25.310] Invocation finished in 55m48.928479058s with status SUCCEEDED