[10:03:54.199] New invocation is queued and will start shortly
[10:03:54.199] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[10:03:55.268] Starting the invocation (attempt 1)
[10:03:55.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:03:55.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:03:55.302] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082002774977601120",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"743ff0eec552244c909970b1c089b04d9e10b28b\",\"root_solution_revision_timestamp\":1554890018}}",
"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:9082002774977601120",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8187",
"user_agent:recipe"
]
}
[10:03:56.288] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554890635412733",
"id": "8916572713040603072",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"743ff0eec552244c909970b1c089b04d9e10b28b\", \"root_solution_revision_timestamp\": 1554890018}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554890636146756",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3521",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8187",
"scheduler_invocation_id:9082002774977601120",
"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/8916572713040603072/+/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": "1554890636146871",
"url": "https://ci.chromium.org/b/8916572713040603072",
"utcnow_ts": "1554890636276628"
}
}
[10:03:56.288] Task URL: https://ci.chromium.org/b/8916572713040603072
[10:03:56.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:2:0) after 1m0s
[10:04:56.287] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:2:0)
[10:04:56.287] Timer tick, asking Buildbucket for the build status
[10:04:56.377] Build 8916572713040603072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:56.377] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:3:0) after 1m0s
[10:05:56.404] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:3:0)
[10:05:56.404] Timer tick, asking Buildbucket for the build status
[10:05:56.580] Build 8916572713040603072: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:56.580] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:4:0) after 1m0s
[10:06:08.094] Received PubSub notification, asking Buildbucket for the build status
[10:06:08.161] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:56.579] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:4:0)
[10:06:56.579] Timer tick, asking Buildbucket for the build status
[10:06:56.738] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:56.738] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:6:0) after 1m0s
[10:07:56.761] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:6:0)
[10:07:56.761] Timer tick, asking Buildbucket for the build status
[10:07:56.867] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:56.868] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:7:0) after 1m0s
[10:08:56.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:7:0)
[10:08:56.886] Timer tick, asking Buildbucket for the build status
[10:08:56.944] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:56.944] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:8:0) after 1m0s
[10:09:56.978] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:8:0)
[10:09:56.978] Timer tick, asking Buildbucket for the build status
[10:09:57.063] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:57.063] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:9:0) after 1m0s
[10:10:57.034] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:9:0)
[10:10:57.034] Timer tick, asking Buildbucket for the build status
[10:10:57.115] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:57.115] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:10:0) after 1m0s
[10:11:57.130] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:10:0)
[10:11:57.130] Timer tick, asking Buildbucket for the build status
[10:11:57.221] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:57.221] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:11:0) after 1m0s
[10:12:57.276] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:11:0)
[10:12:57.276] Timer tick, asking Buildbucket for the build status
[10:12:57.371] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:57.371] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:12:0) after 1m0s
[10:13:57.389] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:12:0)
[10:13:57.389] Timer tick, asking Buildbucket for the build status
[10:13:57.579] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:57.579] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:13:0) after 1m0s
[10:14:57.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:13:0)
[10:14:57.594] Timer tick, asking Buildbucket for the build status
[10:14:57.659] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:57.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:14:0) after 1m0s
[10:15:57.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:14:0)
[10:15:57.688] Timer tick, asking Buildbucket for the build status
[10:15:57.768] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:57.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:15:0) after 1m0s
[10:16:57.743] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:15:0)
[10:16:57.743] Timer tick, asking Buildbucket for the build status
[10:16:57.898] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:57.898] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:16:0) after 1m0s
[10:17:57.914] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:16:0)
[10:17:57.914] Timer tick, asking Buildbucket for the build status
[10:17:58.202] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:58.202] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:17:0) after 1m0s
[10:18:58.175] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:17:0)
[10:18:58.175] Timer tick, asking Buildbucket for the build status
[10:18:58.611] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:58.611] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:18:0) after 1m0s
[10:19:58.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:18:0)
[10:19:58.630] Timer tick, asking Buildbucket for the build status
[10:19:58.697] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:58.697] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:19:0) after 1m0s
[10:20:58.715] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:19:0)
[10:20:58.715] Timer tick, asking Buildbucket for the build status
[10:20:58.915] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:58.915] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:20:0) after 1m0s
[10:21:58.909] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:20:0)
[10:21:58.909] Timer tick, asking Buildbucket for the build status
[10:21:59.015] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:59.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:21:0) after 1m0s
[10:22:59.017] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:21:0)
[10:22:59.017] Timer tick, asking Buildbucket for the build status
[10:22:59.122] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:59.122] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:22:0) after 1m0s
[10:23:59.139] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:22:0)
[10:23:59.139] Timer tick, asking Buildbucket for the build status
[10:23:59.222] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:59.222] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:23:0) after 1m0s
[10:24:59.204] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:23:0)
[10:24:59.204] Timer tick, asking Buildbucket for the build status
[10:24:59.410] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:59.410] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:24:0) after 1m0s
[10:25:59.423] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:24:0)
[10:25:59.423] Timer tick, asking Buildbucket for the build status
[10:25:59.482] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:59.482] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:25:0) after 1m0s
[10:26:59.501] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:25:0)
[10:26:59.501] Timer tick, asking Buildbucket for the build status
[10:26:59.617] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:59.617] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:26:0) after 1m0s
[10:27:59.637] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:26:0)
[10:27:59.637] Timer tick, asking Buildbucket for the build status
[10:27:59.700] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:59.700] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:27:0) after 1m0s
[10:28:59.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:27:0)
[10:28:59.723] Timer tick, asking Buildbucket for the build status
[10:28:59.883] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:59.883] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:28:0) after 1m0s
[10:29:59.916] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:28:0)
[10:29:59.916] Timer tick, asking Buildbucket for the build status
[10:29:59.967] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:59.967] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:29:0) after 1m0s
[10:30:59.996] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:29:0)
[10:30:59.996] Timer tick, asking Buildbucket for the build status
[10:31:00.281] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:00.281] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:30:0) after 1m0s
[10:32:00.260] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:30:0)
[10:32:00.260] Timer tick, asking Buildbucket for the build status
[10:32:00.408] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:00.408] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:31:0) after 1m0s
[10:33:00.385] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:31:0)
[10:33:00.385] Timer tick, asking Buildbucket for the build status
[10:33:00.612] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:00.612] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:32:0) after 1m0s
[10:34:00.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:32:0)
[10:34:00.605] Timer tick, asking Buildbucket for the build status
[10:34:00.756] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:00.756] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:33:0) after 1m0s
[10:35:00.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:33:0)
[10:35:00.732] Timer tick, asking Buildbucket for the build status
[10:35:00.812] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:00.812] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:34:0) after 1m0s
[10:36:00.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:34:0)
[10:36:00.807] Timer tick, asking Buildbucket for the build status
[10:36:00.933] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:00.933] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:35:0) after 1m0s
[10:37:00.912] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:35:0)
[10:37:00.912] Timer tick, asking Buildbucket for the build status
[10:37:00.971] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:00.971] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:36:0) after 1m0s
[10:38:00.974] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:36:0)
[10:38:00.974] Timer tick, asking Buildbucket for the build status
[10:38:01.112] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:01.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:37:0) after 1m0s
[10:39:01.134] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:37:0)
[10:39:01.134] Timer tick, asking Buildbucket for the build status
[10:39:01.245] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:01.245] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:38:0) after 1m0s
[10:40:01.265] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:38:0)
[10:40:01.265] Timer tick, asking Buildbucket for the build status
[10:40:01.459] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:01.459] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:39:0) after 1m0s
[10:41:01.500] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:39:0)
[10:41:01.500] Timer tick, asking Buildbucket for the build status
[10:41:01.974] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:01.974] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:40:0) after 1m0s
[10:42:01.995] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:40:0)
[10:42:01.995] Timer tick, asking Buildbucket for the build status
[10:42:02.430] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:02.430] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:41:0) after 1m0s
[10:43:02.452] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:41:0)
[10:43:02.452] Timer tick, asking Buildbucket for the build status
[10:43:02.503] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:02.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:42:0) after 1m0s
[10:44:02.523] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:42:0)
[10:44:02.523] Timer tick, asking Buildbucket for the build status
[10:44:02.631] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:02.631] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:43:0) after 1m0s
[10:45:02.675] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:43:0)
[10:45:02.675] Timer tick, asking Buildbucket for the build status
[10:45:02.801] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:02.801] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:44:0) after 1m0s
[10:46:02.823] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:44:0)
[10:46:02.823] Timer tick, asking Buildbucket for the build status
[10:46:02.961] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:02.961] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:45:0) after 1m0s
[10:47:02.984] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:45:0)
[10:47:02.984] Timer tick, asking Buildbucket for the build status
[10:47:03.193] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:03.193] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:46:0) after 1m0s
[10:48:03.214] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:46:0)
[10:48:03.215] Timer tick, asking Buildbucket for the build status
[10:48:03.330] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:03.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:47:0) after 1m0s
[10:49:03.317] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:47:0)
[10:49:03.317] Timer tick, asking Buildbucket for the build status
[10:49:03.472] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:03.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:48:0) after 1m0s
[10:50:03.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:48:0)
[10:50:03.515] Timer tick, asking Buildbucket for the build status
[10:50:03.635] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:03.635] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:49:0) after 1m0s
[10:51:03.655] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:49:0)
[10:51:03.655] Timer tick, asking Buildbucket for the build status
[10:51:03.821] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:03.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:50:0) after 1m0s
[10:52:03.924] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:50:0)
[10:52:03.924] Timer tick, asking Buildbucket for the build status
[10:52:04.094] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:04.094] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:51:0) after 1m0s
[10:53:04.101] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:51:0)
[10:53:04.101] Timer tick, asking Buildbucket for the build status
[10:53:04.181] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:04.182] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:52:0) after 1m0s
[10:54:04.251] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:52:0)
[10:54:04.251] Timer tick, asking Buildbucket for the build status
[10:54:04.320] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:04.320] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:53:0) after 1m0s
[10:55:04.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:53:0)
[10:55:04.336] Timer tick, asking Buildbucket for the build status
[10:55:04.398] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:54:0) after 1m0s
[10:56:04.416] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:54:0)
[10:56:04.416] Timer tick, asking Buildbucket for the build status
[10:56:04.491] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.491] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:55:0) after 1m0s
[10:57:04.472] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:55:0)
[10:57:04.472] Timer tick, asking Buildbucket for the build status
[10:57:04.603] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.603] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:56:0) after 1m0s
[10:58:04.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:56:0)
[10:58:04.622] Timer tick, asking Buildbucket for the build status
[10:58:04.706] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:04.706] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:57:0) after 1m0s
[10:59:04.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:57:0)
[10:59:04.690] Timer tick, asking Buildbucket for the build status
[10:59:04.790] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:04.790] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:58:0) after 1m0s
[11:00:04.815] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:58:0)
[11:00:04.815] Timer tick, asking Buildbucket for the build status
[11:00:04.886] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:04.886] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:59:0) after 1m0s
[11:01:04.860] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:59:0)
[11:01:04.860] Timer tick, asking Buildbucket for the build status
[11:01:04.934] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:04.934] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:60:0) after 1m0s
[11:02:04.960] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:60:0)
[11:02:04.960] Timer tick, asking Buildbucket for the build status
[11:02:05.056] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.056] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:61:0) after 1m0s
[11:03:05.079] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:61:0)
[11:03:05.079] Timer tick, asking Buildbucket for the build status
[11:03:05.174] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:05.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:62:0) after 1m0s
[11:04:05.183] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:62:0)
[11:04:05.183] Timer tick, asking Buildbucket for the build status
[11:04:05.267] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:05.267] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:63:0) after 1m0s
[11:05:05.244] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:63:0)
[11:05:05.244] Timer tick, asking Buildbucket for the build status
[11:05:05.377] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:05.377] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:64:0) after 1m0s
[11:06:05.397] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:64:0)
[11:06:05.397] Timer tick, asking Buildbucket for the build status
[11:06:05.467] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:05.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:65:0) after 1m0s
[11:07:05.486] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:65:0)
[11:07:05.486] Timer tick, asking Buildbucket for the build status
[11:07:05.558] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:05.559] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:66:0) after 1m0s
[11:08:05.585] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:66:0)
[11:08:05.585] Timer tick, asking Buildbucket for the build status
[11:08:05.790] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:05.790] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:67:0) after 1m0s
[11:09:05.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:67:0)
[11:09:05.807] Timer tick, asking Buildbucket for the build status
[11:09:05.935] Build 8916572713040603072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:05.935] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082002774977601120:68:0) after 1m0s
[11:09:08.606] Received PubSub notification, asking Buildbucket for the build status
[11:09:08.726] Build 8916572713040603072: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:09:08.726] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554894547999163",
"created_by": "project:infra",
"created_ts": "1554890635412733",
"failure_reason": "BUILD_FAILURE",
"id": "8916572713040603072",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"743ff0eec552244c909970b1c089b04d9e10b28b\", \"root_solution_revision_timestamp\": 1554890018}}",
"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\": 3521, \"got_angle_revision\": \"f39b4f0280ef8dafa7df18c6f0e93e2573e4bf9d\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"b4b3ea05ebde1a1bb6372f8506cd762d040d7978\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"743ff0eec552244c909970b1c089b04d9e10b28b\", \"got_revision_cp\": \"refs/heads/master@{#649456}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"076616f44fc478e46e8c495207ef11cf528f169c\", \"got_v8_revision_cp\": \"refs/heads/7.5.233@{#1}\", \"got_webrtc_revision\": \"f4770401dc296637adb7aec2c8c2b80b65fc94b8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27530}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"743ff0eec552244c909970b1c089b04d9e10b28b\", \"root_solution_revision_timestamp\": 1554890018.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": "1554890767387053",
"status": "COMPLETED",
"status_changed_ts": "1554890767885682",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3521",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8187",
"scheduler_invocation_id:9082002774977601120",
"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/8916572713040603072/+/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:441f85c4bf133210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554894548129783",
"url": "https://ci.chromium.org/b/8916572713040603072",
"utcnow_ts": "1554894548713254"
}
}
[11:09:08.726] Invocation finished in 1h5m14.544871456s with status FAILED