[20:00:56.159] New invocation is queued and will start shortly
[20:00:56.159] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[20:00:57.249] Starting the invocation (attempt 1)
[20:00:57.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:00:57.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:00:57.316] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9081965212930430768",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"e00b6d61bc024123a7fa3671efd2717c1f27bdb8\",\"root_solution_revision_timestamp\":1554926376}}",
"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:9081965212930430768",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8192",
"user_agent:recipe"
]
}
[20:00:59.241] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554926457467417",
"id": "8916535150893265472",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"e00b6d61bc024123a7fa3671efd2717c1f27bdb8\", \"root_solution_revision_timestamp\": 1554926376}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554926457993932",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3526",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8192",
"scheduler_invocation_id:9081965212930430768",
"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/8916535150893265472/+/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": "1554926457994069",
"url": "https://ci.chromium.org/b/8916535150893265472",
"utcnow_ts": "1554926459205874"
}
}
[20:00:59.241] Task URL: https://ci.chromium.org/b/8916535150893265472
[20:00:59.241] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:2:0) after 1m0s
[20:01:34.426] Received PubSub notification, asking Buildbucket for the build status
[20:01:34.474] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.267] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:2:0)
[20:01:59.267] Timer tick, asking Buildbucket for the build status
[20:01:59.462] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.462] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:4:0) after 1m0s
[20:02:59.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:4:0)
[20:02:59.499] Timer tick, asking Buildbucket for the build status
[20:02:59.662] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:59.662] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:5:0) after 1m0s
[20:03:59.678] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:5:0)
[20:03:59.678] Timer tick, asking Buildbucket for the build status
[20:04:00.055] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:00.055] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:6:0) after 1m0s
[20:05:00.149] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:6:0)
[20:05:00.149] Timer tick, asking Buildbucket for the build status
[20:05:00.288] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:00.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:7:0) after 1m0s
[20:06:00.328] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:7:0)
[20:06:00.328] Timer tick, asking Buildbucket for the build status
[20:06:00.491] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:00.491] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:8:0) after 1m0s
[20:07:00.511] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:8:0)
[20:07:00.511] Timer tick, asking Buildbucket for the build status
[20:07:00.768] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:9:0) after 1m0s
[20:08:00.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:9:0)
[20:08:00.807] Timer tick, asking Buildbucket for the build status
[20:08:01.330] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:01.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:10:0) after 1m0s
[20:09:01.339] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:10:0)
[20:09:01.339] Timer tick, asking Buildbucket for the build status
[20:09:01.494] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:01.494] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:11:0) after 1m0s
[20:10:01.513] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:11:0)
[20:10:01.513] Timer tick, asking Buildbucket for the build status
[20:10:01.764] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.764] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:12:0) after 1m0s
[20:11:01.782] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:12:0)
[20:11:01.783] Timer tick, asking Buildbucket for the build status
[20:11:02.017] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:02.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:13:0) after 1m0s
[20:12:02.041] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:13:0)
[20:12:02.041] Timer tick, asking Buildbucket for the build status
[20:12:02.112] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:02.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:14:0) after 1m0s
[20:13:02.136] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:14:0)
[20:13:02.136] Timer tick, asking Buildbucket for the build status
[20:13:02.308] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:02.308] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:15:0) after 1m0s
[20:14:02.325] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:15:0)
[20:14:02.325] Timer tick, asking Buildbucket for the build status
[20:14:02.503] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:02.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:16:0) after 1m0s
[20:15:02.540] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:16:0)
[20:15:02.540] Timer tick, asking Buildbucket for the build status
[20:15:02.622] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:02.622] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:17:0) after 1m0s
[20:16:02.642] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:17:0)
[20:16:02.642] Timer tick, asking Buildbucket for the build status
[20:16:02.789] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:02.789] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:18:0) after 1m0s
[20:17:02.821] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:18:0)
[20:17:02.821] Timer tick, asking Buildbucket for the build status
[20:17:02.896] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:02.896] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:19:0) after 1m0s
[20:18:02.919] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:19:0)
[20:18:02.919] Timer tick, asking Buildbucket for the build status
[20:18:02.978] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:02.978] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:20:0) after 1m0s
[20:19:03.025] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:20:0)
[20:19:03.025] Timer tick, asking Buildbucket for the build status
[20:19:03.132] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:03.132] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:21:0) after 1m0s
[20:20:03.149] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:21:0)
[20:20:03.149] Timer tick, asking Buildbucket for the build status
[20:20:03.256] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:03.256] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:22:0) after 1m0s
[20:21:03.274] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:22:0)
[20:21:03.274] Timer tick, asking Buildbucket for the build status
[20:21:03.338] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:03.338] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:23:0) after 1m0s
[20:22:03.361] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:23:0)
[20:22:03.361] Timer tick, asking Buildbucket for the build status
[20:22:03.491] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:03.491] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:24:0) after 1m0s
[20:23:03.508] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:24:0)
[20:23:03.508] Timer tick, asking Buildbucket for the build status
[20:23:03.553] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:03.553] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:25:0) after 1m0s
[20:24:03.572] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:25:0)
[20:24:03.572] Timer tick, asking Buildbucket for the build status
[20:24:03.627] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:03.627] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:26:0) after 1m0s
[20:25:03.645] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:26:0)
[20:25:03.645] Timer tick, asking Buildbucket for the build status
[20:25:03.897] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:03.897] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:27:0) after 1m0s
[20:26:03.917] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:27:0)
[20:26:03.917] Timer tick, asking Buildbucket for the build status
[20:26:03.964] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:03.964] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:28:0) after 1m0s
[20:27:03.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:28:0)
[20:27:03.986] Timer tick, asking Buildbucket for the build status
[20:27:04.075] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:04.075] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:29:0) after 1m0s
[20:28:04.120] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:29:0)
[20:28:04.120] Timer tick, asking Buildbucket for the build status
[20:28:04.496] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:04.496] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:30:0) after 1m0s
[20:29:04.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:30:0)
[20:29:04.499] Timer tick, asking Buildbucket for the build status
[20:29:04.979] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:04.979] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:31:0) after 1m0s
[20:30:05.000] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:31:0)
[20:30:05.000] Timer tick, asking Buildbucket for the build status
[20:30:05.144] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:05.144] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:32:0) after 1m0s
[20:31:05.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:32:0)
[20:31:05.165] Timer tick, asking Buildbucket for the build status
[20:31:05.217] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:05.217] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:33:0) after 1m0s
[20:32:05.292] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:33:0)
[20:32:05.292] Timer tick, asking Buildbucket for the build status
[20:32:05.456] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:05.456] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:34:0) after 1m0s
[20:33:05.474] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:34:0)
[20:33:05.474] Timer tick, asking Buildbucket for the build status
[20:33:05.531] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:05.531] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:35:0) after 1m0s
[20:34:05.554] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:35:0)
[20:34:05.554] Timer tick, asking Buildbucket for the build status
[20:34:06.478] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:06.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:36:0) after 1m0s
[20:35:06.477] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:36:0)
[20:35:06.477] Timer tick, asking Buildbucket for the build status
[20:35:06.542] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:06.542] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:37:0) after 1m0s
[20:36:06.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:37:0)
[20:36:06.553] Timer tick, asking Buildbucket for the build status
[20:36:06.605] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:06.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:38:0) after 1m0s
[20:37:06.624] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:38:0)
[20:37:06.624] Timer tick, asking Buildbucket for the build status
[20:37:06.793] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:06.793] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:39:0) after 1m0s
[20:38:06.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:39:0)
[20:38:06.812] Timer tick, asking Buildbucket for the build status
[20:38:07.005] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:07.005] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:40:0) after 1m0s
[20:39:07.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:40:0)
[20:39:07.028] Timer tick, asking Buildbucket for the build status
[20:39:07.101] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.101] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:41:0) after 1m0s
[20:40:07.115] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:41:0)
[20:40:07.115] Timer tick, asking Buildbucket for the build status
[20:40:07.207] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:07.207] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:42:0) after 1m0s
[20:41:07.226] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:42:0)
[20:41:07.226] Timer tick, asking Buildbucket for the build status
[20:41:07.368] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:07.368] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:43:0) after 1m0s
[20:42:07.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:43:0)
[20:42:07.388] Timer tick, asking Buildbucket for the build status
[20:42:07.445] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:07.445] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:44:0) after 1m0s
[20:43:07.457] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:44:0)
[20:43:07.457] Timer tick, asking Buildbucket for the build status
[20:43:07.520] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:07.520] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:45:0) after 1m0s
[20:44:07.604] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:45:0)
[20:44:07.604] Timer tick, asking Buildbucket for the build status
[20:44:07.769] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:07.769] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:46:0) after 1m0s
[20:45:07.804] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:46:0)
[20:45:07.804] Timer tick, asking Buildbucket for the build status
[20:45:07.983] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:07.983] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:47:0) after 1m0s
[20:46:07.968] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:47:0)
[20:46:07.968] Timer tick, asking Buildbucket for the build status
[20:46:08.100] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:08.100] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:48:0) after 1m0s
[20:47:08.086] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:48:0)
[20:47:08.086] Timer tick, asking Buildbucket for the build status
[20:47:08.488] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:08.488] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:49:0) after 1m0s
[20:48:08.513] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:49:0)
[20:48:08.513] Timer tick, asking Buildbucket for the build status
[20:48:08.758] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:08.758] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:50:0) after 1m0s
[20:49:08.754] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:50:0)
[20:49:08.754] Timer tick, asking Buildbucket for the build status
[20:49:09.024] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:09.024] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:51:0) after 1m0s
[20:50:09.047] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:51:0)
[20:50:09.047] Timer tick, asking Buildbucket for the build status
[20:50:09.089] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:09.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:52:0) after 1m0s
[20:51:09.119] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:52:0)
[20:51:09.119] Timer tick, asking Buildbucket for the build status
[20:51:09.193] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:09.193] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:53:0) after 1m0s
[20:52:09.213] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:53:0)
[20:52:09.213] Timer tick, asking Buildbucket for the build status
[20:52:09.289] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:09.289] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:54:0) after 1m0s
[20:53:09.306] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:54:0)
[20:53:09.306] Timer tick, asking Buildbucket for the build status
[20:53:09.523] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:09.523] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:55:0) after 1m0s
[20:54:09.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:55:0)
[20:54:09.542] Timer tick, asking Buildbucket for the build status
[20:54:09.594] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:09.594] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:56:0) after 1m0s
[20:55:09.601] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:56:0)
[20:55:09.601] Timer tick, asking Buildbucket for the build status
[20:55:09.686] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:09.686] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:57:0) after 1m0s
[20:56:09.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:57:0)
[20:56:09.704] Timer tick, asking Buildbucket for the build status
[20:56:09.775] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:09.775] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:58:0) after 1m0s
[20:57:09.804] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:58:0)
[20:57:09.804] Timer tick, asking Buildbucket for the build status
[20:57:09.987] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:09.987] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:59:0) after 1m0s
[20:58:10.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:59:0)
[20:58:10.016] Timer tick, asking Buildbucket for the build status
[20:58:10.124] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:10.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:60:0) after 1m0s
[20:59:10.149] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:60:0)
[20:59:10.149] Timer tick, asking Buildbucket for the build status
[20:59:10.205] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:10.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:61:0) after 1m0s
[21:00:10.250] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:61:0)
[21:00:10.250] Timer tick, asking Buildbucket for the build status
[21:00:10.418] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:10.418] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:62:0) after 1m0s
[21:01:10.427] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:62:0)
[21:01:10.427] Timer tick, asking Buildbucket for the build status
[21:01:10.469] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:10.469] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:63:0) after 1m0s
[21:02:10.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:63:0)
[21:02:10.499] Timer tick, asking Buildbucket for the build status
[21:02:10.637] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.638] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:64:0) after 1m0s
[21:03:10.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:64:0)
[21:03:10.630] Timer tick, asking Buildbucket for the build status
[21:03:10.778] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:10.778] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:65:0) after 1m0s
[21:04:10.799] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:65:0)
[21:04:10.799] Timer tick, asking Buildbucket for the build status
[21:04:10.850] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:10.850] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:66:0) after 1m0s
[21:05:10.873] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:66:0)
[21:05:10.873] Timer tick, asking Buildbucket for the build status
[21:05:11.056] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.056] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:67:0) after 1m0s
[21:06:11.079] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:67:0)
[21:06:11.079] Timer tick, asking Buildbucket for the build status
[21:06:11.130] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:11.130] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:68:0) after 1m0s
[21:07:11.152] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:68:0)
[21:07:11.152] Timer tick, asking Buildbucket for the build status
[21:07:11.295] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:11.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:69:0) after 1m0s
[21:08:11.276] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:69:0)
[21:08:11.276] Timer tick, asking Buildbucket for the build status
[21:08:11.325] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:11.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:70:0) after 1m0s
[21:09:11.347] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:70:0)
[21:09:11.347] Timer tick, asking Buildbucket for the build status
[21:09:11.681] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:11.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:71:0) after 1m0s
[21:10:11.662] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:71:0)
[21:10:11.662] Timer tick, asking Buildbucket for the build status
[21:10:11.739] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:11.739] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:72:0) after 1m0s
[21:11:11.760] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:72:0)
[21:11:11.760] Timer tick, asking Buildbucket for the build status
[21:11:11.810] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:11.810] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:73:0) after 1m0s
[21:12:11.819] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:73:0)
[21:12:11.819] Timer tick, asking Buildbucket for the build status
[21:12:11.865] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:11.865] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:74:0) after 1m0s
[21:13:11.852] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:74:0)
[21:13:11.852] Timer tick, asking Buildbucket for the build status
[21:13:11.910] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:11.910] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:75:0) after 1m0s
[21:14:11.894] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:75:0)
[21:14:11.894] Timer tick, asking Buildbucket for the build status
[21:14:11.969] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:11.969] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:76:0) after 1m0s
[21:15:11.939] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:76:0)
[21:15:11.939] Timer tick, asking Buildbucket for the build status
[21:15:11.999] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:11.999] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:77:0) after 1m0s
[21:16:12.024] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:77:0)
[21:16:12.024] Timer tick, asking Buildbucket for the build status
[21:16:12.162] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:12.162] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:78:0) after 1m0s
[21:17:12.192] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:78:0)
[21:17:12.192] Timer tick, asking Buildbucket for the build status
[21:17:12.347] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:12.347] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:79:0) after 1m0s
[21:18:12.340] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:79:0)
[21:18:12.341] Timer tick, asking Buildbucket for the build status
[21:18:12.586] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:12.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:80:0) after 1m0s
[21:19:12.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:80:0)
[21:19:12.592] Timer tick, asking Buildbucket for the build status
[21:19:12.721] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:12.721] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:81:0) after 1m0s
[21:20:12.743] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:81:0)
[21:20:12.743] Timer tick, asking Buildbucket for the build status
[21:20:12.784] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:12.784] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:82:0) after 1m0s
[21:21:12.829] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:82:0)
[21:21:12.829] Timer tick, asking Buildbucket for the build status
[21:21:13.082] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:13.082] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:83:0) after 1m0s
[21:22:13.083] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:83:0)
[21:22:13.083] Timer tick, asking Buildbucket for the build status
[21:22:13.386] Build 8916535150893265472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:13.386] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9081965212930430768:84:0) after 1m0s
[21:22:52.583] Received PubSub notification, asking Buildbucket for the build status
[21:22:52.772] Build 8916535150893265472: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:22:52.772] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554931371954869",
"created_by": "project:infra",
"created_ts": "1554926457467417",
"failure_reason": "BUILD_FAILURE",
"id": "8916535150893265472",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"e00b6d61bc024123a7fa3671efd2717c1f27bdb8\", \"root_solution_revision_timestamp\": 1554926376}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compile') 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\": 3526, \"got_angle_revision\": \"76a9a97fb2a19a325ef90c10900718bfbdb4b1d3\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"b4b3ea05ebde1a1bb6372f8506cd762d040d7978\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"e00b6d61bc024123a7fa3671efd2717c1f27bdb8\", \"got_revision_cp\": \"refs/heads/master@{#649616}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"7274e4b564c81c5380b5673003f0aab25c9a3f85\", \"got_v8_revision_cp\": \"refs/heads/7.5.241@{#1}\", \"got_webrtc_revision\": \"0951cfd13e291613a77c5357eba2bd94d6e7f7d8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27548}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"e00b6d61bc024123a7fa3671efd2717c1f27bdb8\", \"root_solution_revision_timestamp\": 1554926376.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('compile') failed with return_code 1\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554926492731774",
"status": "COMPLETED",
"status_changed_ts": "1554926494020891",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3526",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8192",
"scheduler_invocation_id:9081965212930430768",
"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/8916535150893265472/+/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:4421a861e1344f10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554931372012020",
"url": "https://ci.chromium.org/b/8916535150893265472",
"utcnow_ts": "1554931372763329"
}
}
[21:22:52.772] Invocation finished in 1h21m56.631147554s with status FAILED