[12:38:20.228] New invocation is queued and will start shortly
[12:38:20.228] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:38:21.304] Starting the invocation (attempt 1)
[12:38:21.349] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:38:21.349] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:38:21.349] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082355446715478640",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"2050a2554b2eccaa2098e7e1f2a6e6def1104a89\",\"root_solution_revision_timestamp\":1554551997}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-win",
"scheduler_invocation_id:9082355446715478640",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8140",
"user_agent:recipe"
]
}
[12:38:22.224] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554554301546008",
"id": "8916925384660763856",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"2050a2554b2eccaa2098e7e1f2a6e6def1104a89\", \"root_solution_revision_timestamp\": 1554551997}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554554302070107",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3487",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8140",
"scheduler_invocation_id:9082355446715478640",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8916925384660763856/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554554302070421",
"url": "https://ci.chromium.org/b/8916925384660763856",
"utcnow_ts": "1554554302214112"
}
}
[12:38:22.224] Task URL: https://ci.chromium.org/b/8916925384660763856
[12:38:22.224] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:2:0) after 1m0s
[12:39:22.241] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:2:0)
[12:39:22.241] Timer tick, asking Buildbucket for the build status
[12:39:22.328] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:22.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:3:0) after 1m0s
[12:40:22.346] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:3:0)
[12:40:22.346] Timer tick, asking Buildbucket for the build status
[12:40:22.539] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:22.539] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:4:0) after 1m0s
[12:41:22.556] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:4:0)
[12:41:22.556] Timer tick, asking Buildbucket for the build status
[12:41:22.630] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:22.630] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:5:0) after 1m0s
[12:42:22.647] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:5:0)
[12:42:22.647] Timer tick, asking Buildbucket for the build status
[12:42:22.727] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:22.727] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:6:0) after 1m0s
[12:43:22.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:6:0)
[12:43:22.744] Timer tick, asking Buildbucket for the build status
[12:43:22.853] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:22.853] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:7:0) after 1m0s
[12:44:22.870] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:7:0)
[12:44:22.870] Timer tick, asking Buildbucket for the build status
[12:44:23.112] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:23.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:8:0) after 1m0s
[12:45:23.196] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:8:0)
[12:45:23.196] Timer tick, asking Buildbucket for the build status
[12:45:23.286] Build 8916925384660763856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:45:23.286] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:9:0) after 1m0s
[12:46:23.286] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:9:0)
[12:46:23.286] Timer tick, asking Buildbucket for the build status
[12:46:23.430] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:23.431] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:10:0) after 1m0s
[12:46:23.567] Received PubSub notification, asking Buildbucket for the build status
[12:46:23.639] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:23.451] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:10:0)
[12:47:23.451] Timer tick, asking Buildbucket for the build status
[12:47:23.526] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:23.526] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:12:0) after 1m0s
[12:48:23.554] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:12:0)
[12:48:23.554] Timer tick, asking Buildbucket for the build status
[12:48:23.649] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:23.649] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:13:0) after 1m0s
[12:49:23.641] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:13:0)
[12:49:23.641] Timer tick, asking Buildbucket for the build status
[12:49:23.713] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:23.713] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:14:0) after 1m0s
[12:50:23.734] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:14:0)
[12:50:23.734] Timer tick, asking Buildbucket for the build status
[12:50:23.822] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:23.822] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:15:0) after 1m0s
[12:51:23.838] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:15:0)
[12:51:23.838] Timer tick, asking Buildbucket for the build status
[12:51:24.044] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:24.044] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:16:0) after 1m0s
[12:52:24.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:16:0)
[12:52:24.052] Timer tick, asking Buildbucket for the build status
[12:52:24.293] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:24.293] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:17:0) after 1m0s
[12:53:24.272] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:17:0)
[12:53:24.272] Timer tick, asking Buildbucket for the build status
[12:53:24.493] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:24.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:18:0) after 1m0s
[12:54:24.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:18:0)
[12:54:24.499] Timer tick, asking Buildbucket for the build status
[12:54:24.624] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:24.624] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:19:0) after 1m0s
[12:55:24.646] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:19:0)
[12:55:24.646] Timer tick, asking Buildbucket for the build status
[12:55:24.701] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:24.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:20:0) after 1m0s
[12:56:24.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:20:0)
[12:56:24.744] Timer tick, asking Buildbucket for the build status
[12:56:24.879] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:24.879] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:21:0) after 1m0s
[12:57:24.911] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:21:0)
[12:57:24.911] Timer tick, asking Buildbucket for the build status
[12:57:24.990] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:24.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:22:0) after 1m0s
[12:58:24.984] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:22:0)
[12:58:24.984] Timer tick, asking Buildbucket for the build status
[12:58:25.071] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:25.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:23:0) after 1m0s
[12:59:25.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:23:0)
[12:59:25.052] Timer tick, asking Buildbucket for the build status
[12:59:25.263] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:25.264] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:24:0) after 1m0s
[13:00:25.279] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:24:0)
[13:00:25.279] Timer tick, asking Buildbucket for the build status
[13:00:25.356] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:25.356] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:25:0) after 1m0s
[13:01:25.375] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:25:0)
[13:01:25.375] Timer tick, asking Buildbucket for the build status
[13:01:25.478] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:25.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:26:0) after 1m0s
[13:02:25.539] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:26:0)
[13:02:25.539] Timer tick, asking Buildbucket for the build status
[13:02:25.642] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:25.642] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:27:0) after 1m0s
[13:03:25.663] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:27:0)
[13:03:25.663] Timer tick, asking Buildbucket for the build status
[13:03:25.741] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:25.741] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:28:0) after 1m0s
[13:04:25.761] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:28:0)
[13:04:25.761] Timer tick, asking Buildbucket for the build status
[13:04:25.821] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:25.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:29:0) after 1m0s
[13:05:25.840] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:29:0)
[13:05:25.840] Timer tick, asking Buildbucket for the build status
[13:05:26.178] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:26.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:30:0) after 1m0s
[13:06:26.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:30:0)
[13:06:26.209] Timer tick, asking Buildbucket for the build status
[13:06:26.272] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:26.272] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:31:0) after 1m0s
[13:07:26.272] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:31:0)
[13:07:26.272] Timer tick, asking Buildbucket for the build status
[13:07:26.655] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:26.655] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:32:0) after 1m0s
[13:08:26.674] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:32:0)
[13:08:26.674] Timer tick, asking Buildbucket for the build status
[13:08:26.758] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:26.758] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:33:0) after 1m0s
[13:09:26.775] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:33:0)
[13:09:26.775] Timer tick, asking Buildbucket for the build status
[13:09:26.855] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:26.855] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:34:0) after 1m0s
[13:10:26.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:34:0)
[13:10:26.886] Timer tick, asking Buildbucket for the build status
[13:10:27.071] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:27.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:35:0) after 1m0s
[13:11:27.089] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:35:0)
[13:11:27.089] Timer tick, asking Buildbucket for the build status
[13:11:27.174] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:27.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:36:0) after 1m0s
[13:12:27.193] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:36:0)
[13:12:27.193] Timer tick, asking Buildbucket for the build status
[13:12:27.291] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:27.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:37:0) after 1m0s
[13:13:27.290] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:37:0)
[13:13:27.290] Timer tick, asking Buildbucket for the build status
[13:13:27.382] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:27.382] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:38:0) after 1m0s
[13:14:27.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:38:0)
[13:14:27.401] Timer tick, asking Buildbucket for the build status
[13:14:27.645] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:27.645] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:39:0) after 1m0s
[13:15:27.683] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:39:0)
[13:15:27.683] Timer tick, asking Buildbucket for the build status
[13:15:27.784] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:27.784] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:40:0) after 1m0s
[13:16:27.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:40:0)
[13:16:27.802] Timer tick, asking Buildbucket for the build status
[13:16:28.169] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:28.169] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:41:0) after 1m0s
[13:17:28.239] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:41:0)
[13:17:28.239] Timer tick, asking Buildbucket for the build status
[13:17:28.328] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:28.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:42:0) after 1m0s
[13:18:28.349] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:42:0)
[13:18:28.349] Timer tick, asking Buildbucket for the build status
[13:18:28.413] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:28.413] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:43:0) after 1m0s
[13:19:28.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:43:0)
[13:19:28.399] Timer tick, asking Buildbucket for the build status
[13:19:28.575] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:28.575] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:44:0) after 1m0s
[13:20:28.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:44:0)
[13:20:28.594] Timer tick, asking Buildbucket for the build status
[13:20:28.672] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:28.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:45:0) after 1m0s
[13:21:28.691] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:45:0)
[13:21:28.691] Timer tick, asking Buildbucket for the build status
[13:21:28.748] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:28.748] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:46:0) after 1m0s
[13:22:28.767] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:46:0)
[13:22:28.767] Timer tick, asking Buildbucket for the build status
[13:22:28.873] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:28.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:47:0) after 1m0s
[13:23:28.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:47:0)
[13:23:28.892] Timer tick, asking Buildbucket for the build status
[13:23:28.981] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:28.981] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:48:0) after 1m0s
[13:24:28.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:48:0)
[13:24:28.969] Timer tick, asking Buildbucket for the build status
[13:24:29.033] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:29.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:49:0) after 1m0s
[13:25:29.096] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:49:0)
[13:25:29.096] Timer tick, asking Buildbucket for the build status
[13:25:29.174] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:29.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:50:0) after 1m0s
[13:26:29.212] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:50:0)
[13:26:29.212] Timer tick, asking Buildbucket for the build status
[13:26:29.323] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:29.323] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:51:0) after 1m0s
[13:27:29.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:51:0)
[13:27:29.406] Timer tick, asking Buildbucket for the build status
[13:27:29.475] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:29.475] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:52:0) after 1m0s
[13:28:29.474] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:52:0)
[13:28:29.474] Timer tick, asking Buildbucket for the build status
[13:28:29.585] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:29.585] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:53:0) after 1m0s
[13:29:29.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:53:0)
[13:29:29.561] Timer tick, asking Buildbucket for the build status
[13:29:29.625] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:29.625] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:54:0) after 1m0s
[13:30:29.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:54:0)
[13:30:29.653] Timer tick, asking Buildbucket for the build status
[13:30:29.815] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:29.815] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:55:0) after 1m0s
[13:31:29.835] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:55:0)
[13:31:29.835] Timer tick, asking Buildbucket for the build status
[13:31:29.915] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:29.915] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:56:0) after 1m0s
[13:32:29.935] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:56:0)
[13:32:29.935] Timer tick, asking Buildbucket for the build status
[13:32:30.100] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:30.100] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:57:0) after 1m0s
[13:33:30.138] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:57:0)
[13:33:30.138] Timer tick, asking Buildbucket for the build status
[13:33:30.337] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:30.337] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:58:0) after 1m0s
[13:34:30.356] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:58:0)
[13:34:30.356] Timer tick, asking Buildbucket for the build status
[13:34:30.465] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:30.465] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:59:0) after 1m0s
[13:35:30.485] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:59:0)
[13:35:30.485] Timer tick, asking Buildbucket for the build status
[13:35:30.661] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:30.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:60:0) after 1m0s
[13:36:30.682] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:60:0)
[13:36:30.682] Timer tick, asking Buildbucket for the build status
[13:36:30.746] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:30.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:61:0) after 1m0s
[13:37:30.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:61:0)
[13:37:30.757] Timer tick, asking Buildbucket for the build status
[13:37:30.890] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:30.890] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:62:0) after 1m0s
[13:38:30.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:62:0)
[13:38:30.871] Timer tick, asking Buildbucket for the build status
[13:38:31.089] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:31.090] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:63:0) after 1m0s
[13:39:31.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:63:0)
[13:39:31.126] Timer tick, asking Buildbucket for the build status
[13:39:31.263] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:31.263] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:64:0) after 1m0s
[13:40:31.285] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:64:0)
[13:40:31.285] Timer tick, asking Buildbucket for the build status
[13:40:31.414] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:31.414] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:65:0) after 1m0s
[13:41:31.432] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:65:0)
[13:41:31.432] Timer tick, asking Buildbucket for the build status
[13:41:31.787] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:31.787] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:66:0) after 1m0s
[13:42:31.786] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:66:0)
[13:42:31.786] Timer tick, asking Buildbucket for the build status
[13:42:31.949] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:31.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:67:0) after 1m0s
[13:43:31.971] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:67:0)
[13:43:31.971] Timer tick, asking Buildbucket for the build status
[13:43:32.070] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:32.070] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:68:0) after 1m0s
[13:44:32.090] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:68:0)
[13:44:32.090] Timer tick, asking Buildbucket for the build status
[13:44:32.249] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:32.249] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:69:0) after 1m0s
[13:45:32.252] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:69:0)
[13:45:32.252] Timer tick, asking Buildbucket for the build status
[13:45:32.333] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:32.333] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:70:0) after 1m0s
[13:46:32.353] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:70:0)
[13:46:32.353] Timer tick, asking Buildbucket for the build status
[13:46:32.416] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:32.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:71:0) after 1m0s
[13:47:32.439] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:71:0)
[13:47:32.439] Timer tick, asking Buildbucket for the build status
[13:47:32.570] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:32.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:72:0) after 1m0s
[13:48:32.590] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:72:0)
[13:48:32.590] Timer tick, asking Buildbucket for the build status
[13:48:32.858] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:32.858] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:73:0) after 1m0s
[13:49:32.877] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:73:0)
[13:49:32.877] Timer tick, asking Buildbucket for the build status
[13:49:32.945] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:32.945] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:74:0) after 1m0s
[13:50:32.966] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:74:0)
[13:50:32.966] Timer tick, asking Buildbucket for the build status
[13:50:33.022] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:33.022] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:75:0) after 1m0s
[13:51:33.044] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:75:0)
[13:51:33.044] Timer tick, asking Buildbucket for the build status
[13:51:33.310] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:33.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:76:0) after 1m0s
[13:52:33.341] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:76:0)
[13:52:33.341] Timer tick, asking Buildbucket for the build status
[13:52:33.407] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:33.407] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:77:0) after 1m0s
[13:53:33.458] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:77:0)
[13:53:33.458] Timer tick, asking Buildbucket for the build status
[13:53:33.516] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:33.516] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:78:0) after 1m0s
[13:54:33.512] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:78:0)
[13:54:33.512] Timer tick, asking Buildbucket for the build status
[13:54:33.597] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:33.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:79:0) after 1m0s
[13:55:33.621] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:79:0)
[13:55:33.621] Timer tick, asking Buildbucket for the build status
[13:55:33.867] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:33.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:80:0) after 1m0s
[13:56:33.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:80:0)
[13:56:33.881] Timer tick, asking Buildbucket for the build status
[13:56:33.940] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:33.940] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:81:0) after 1m0s
[13:57:33.963] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:81:0)
[13:57:33.963] Timer tick, asking Buildbucket for the build status
[13:57:34.051] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:34.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:82:0) after 1m0s
[13:58:34.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:82:0)
[13:58:34.085] Timer tick, asking Buildbucket for the build status
[13:58:34.308] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:34.308] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:83:0) after 1m0s
[13:59:34.338] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:83:0)
[13:59:34.338] Timer tick, asking Buildbucket for the build status
[13:59:34.405] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:34.405] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:84:0) after 1m0s
[14:00:34.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:84:0)
[14:00:34.431] Timer tick, asking Buildbucket for the build status
[14:00:34.505] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:34.505] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:85:0) after 1m0s
[14:01:34.526] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:85:0)
[14:01:34.526] Timer tick, asking Buildbucket for the build status
[14:01:34.610] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:34.610] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:86:0) after 1m0s
[14:02:34.633] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:86:0)
[14:02:34.633] Timer tick, asking Buildbucket for the build status
[14:02:34.724] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:34.724] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:87:0) after 1m0s
[14:03:34.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:87:0)
[14:03:34.736] Timer tick, asking Buildbucket for the build status
[14:03:34.803] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:34.803] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:88:0) after 1m0s
[14:04:34.825] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:88:0)
[14:04:34.825] Timer tick, asking Buildbucket for the build status
[14:04:34.894] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:34.894] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:89:0) after 1m0s
[14:05:35.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:89:0)
[14:05:35.013] Timer tick, asking Buildbucket for the build status
[14:05:35.099] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:35.099] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:90:0) after 1m0s
[14:06:35.092] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:90:0)
[14:06:35.092] Timer tick, asking Buildbucket for the build status
[14:06:35.159] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:35.159] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:91:0) after 1m0s
[14:07:35.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:91:0)
[14:07:35.209] Timer tick, asking Buildbucket for the build status
[14:07:35.280] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:35.280] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:92:0) after 1m0s
[14:08:35.314] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:92:0)
[14:08:35.314] Timer tick, asking Buildbucket for the build status
[14:08:35.499] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:35.499] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:93:0) after 1m0s
[14:09:35.520] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:93:0)
[14:09:35.520] Timer tick, asking Buildbucket for the build status
[14:09:35.754] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:35.754] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:94:0) after 1m0s
[14:10:35.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:94:0)
[14:10:35.777] Timer tick, asking Buildbucket for the build status
[14:10:35.883] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:35.883] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:95:0) after 1m0s
[14:11:35.872] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:95:0)
[14:11:35.872] Timer tick, asking Buildbucket for the build status
[14:11:35.936] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:35.936] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:96:0) after 1m0s
[14:12:35.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:96:0)
[14:12:35.955] Timer tick, asking Buildbucket for the build status
[14:12:36.017] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:36.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:97:0) after 1m0s
[14:13:36.039] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:97:0)
[14:13:36.039] Timer tick, asking Buildbucket for the build status
[14:13:36.379] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:36.379] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:98:0) after 1m0s
[14:14:36.403] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:98:0)
[14:14:36.403] Timer tick, asking Buildbucket for the build status
[14:14:36.901] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:36.901] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:99:0) after 1m0s
[14:15:36.896] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:99:0)
[14:15:36.896] Timer tick, asking Buildbucket for the build status
[14:15:36.950] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:36.950] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:100:0) after 1m0s
[14:16:36.970] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:100:0)
[14:16:36.970] Timer tick, asking Buildbucket for the build status
[14:16:37.165] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:37.165] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:101:0) after 1m0s
[14:17:37.186] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:101:0)
[14:17:37.186] Timer tick, asking Buildbucket for the build status
[14:17:37.253] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:37.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:102:0) after 1m0s
[14:18:37.320] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:102:0)
[14:18:37.320] Timer tick, asking Buildbucket for the build status
[14:18:37.474] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:37.474] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:103:0) after 1m0s
[14:19:37.493] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:103:0)
[14:19:37.493] Timer tick, asking Buildbucket for the build status
[14:19:37.719] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:37.719] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:104:0) after 1m0s
[14:20:37.717] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:104:0)
[14:20:37.717] Timer tick, asking Buildbucket for the build status
[14:20:37.808] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:37.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:105:0) after 1m0s
[14:21:37.842] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:105:0)
[14:21:37.842] Timer tick, asking Buildbucket for the build status
[14:21:37.895] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:37.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:106:0) after 1m0s
[14:22:37.916] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:106:0)
[14:22:37.916] Timer tick, asking Buildbucket for the build status
[14:22:38.007] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:38.007] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:107:0) after 1m0s
[14:23:38.018] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:107:0)
[14:23:38.018] Timer tick, asking Buildbucket for the build status
[14:23:38.124] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:38.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:108:0) after 1m0s
[14:24:38.164] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:108:0)
[14:24:38.164] Timer tick, asking Buildbucket for the build status
[14:24:38.467] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:38.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:109:0) after 1m0s
[14:25:38.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:109:0)
[14:25:38.487] Timer tick, asking Buildbucket for the build status
[14:25:38.615] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:38.615] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:110:0) after 1m0s
[14:26:38.619] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:110:0)
[14:26:38.619] Timer tick, asking Buildbucket for the build status
[14:26:38.692] Build 8916925384660763856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:38.692] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:111:0) after 1m0s
[14:27:38.712] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082355446715478640:111:0)
[14:27:38.712] Timer tick, asking Buildbucket for the build status
[14:27:38.765] Build 8916925384660763856: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:27:38.765] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554560858443801",
"created_by": "project:infra",
"created_ts": "1554554301546008",
"failure_reason": "BUILD_FAILURE",
"id": "8916925384660763856",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"2050a2554b2eccaa2098e7e1f2a6e6def1104a89\", \"root_solution_revision_timestamp\": 1554551997}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('add kythe metadata') failed with return_code 1\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm2223-c4\", \"buildername\": \"codesearch-gen-chromium-win\", \"buildnumber\": 3487, \"got_angle_revision\": \"5f388c24529334c694e245be69226581a01d1622\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\", \"got_revision\": \"2050a2554b2eccaa2098e7e1f2a6e6def1104a89\", \"got_revision_cp\": \"refs/heads/master@{#648478}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"72592828213b06ab2f4b69f2ed5685c1e43123b1\", \"got_v8_revision_cp\": \"refs/heads/7.5.202@{#1}\", \"got_webrtc_revision\": \"59e875ce18bb24aa6d1ec5cdf128d7ef244fa37a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27463}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"2050a2554b2eccaa2098e7e1f2a6e6def1104a89\", \"root_solution_revision_timestamp\": 1554551997.0}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"codesearch-gen-chromium-win\"], \"caches\": [\"builder_51272234846e6a2cd04aa26557e39158e034c42367eea2a83e543ed93811995b_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm2223-c4\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"Step('add kythe metadata') failed with return_code 1\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554554782884436",
"status": "COMPLETED",
"status_changed_ts": "1554554783293819",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3487",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8140",
"scheduler_invocation_id:9082355446715478640",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8916925384660763856/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:440b79b7d4a5e310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554560858494004",
"url": "https://ci.chromium.org/b/8916925384660763856",
"utcnow_ts": "1554560858756066"
}
}
[14:27:38.765] Invocation finished in 1h49m18.562077257s with status FAILED