[03:00:54.238] New invocation is queued and will start shortly
[03:00:55.520] Starting the invocation (attempt 1)
[03:00:55.555] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:55.555] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:55.555] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9101507735610658976",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-linux\",\"properties\":{\"root_solution_revision\":\"bfbc8215d5482b4c804f42d5728d8d29f5ddd500\",\"root_solution_revision_timestamp\":1536288530}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-linux",
"scheduler_invocation_id:9101507735610658976",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5627",
"user_agent:recipe"
]
}
[03:00:56.736] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536289255671938",
"id": "8936077673404068992",
"lease_expiration_ts": "1536404456559940",
"lease_key": "904212829",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"bfbc8215d5482b4c804f42d5728d8d29f5ddd500\", \"root_solution_revision_timestamp\": 1536288530}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536289256647554",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5627",
"scheduler_invocation_id:9101507735610658976",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"swarming_dimension:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.codesearch",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8936077673404068992",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936077673404068992/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5627",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101507735610658976",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:d35ad0202050590393072590ac52b8068d1c49f9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fcacb3ba3cfbb10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1536289256647639",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"utcnow_ts": "1536289256724085"
}
}
[03:00:56.736] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3483
[03:00:56.736] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:2:0) after 1m0s
[03:01:55.333] Received PubSub notification, asking Buildbucket for the build status
[03:01:55.447] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:56.753] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:2:0)
[03:01:56.753] Timer tick, asking Buildbucket for the build status
[03:01:56.795] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:56.795] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:4:0) after 1m0s
[03:02:56.826] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:4:0)
[03:02:56.826] Timer tick, asking Buildbucket for the build status
[03:02:56.902] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:56.902] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:5:0) after 1m0s
[03:03:57.034] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:5:0)
[03:03:57.034] Timer tick, asking Buildbucket for the build status
[03:03:57.145] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:57.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:6:0) after 1m0s
[03:04:57.161] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:6:0)
[03:04:57.161] Timer tick, asking Buildbucket for the build status
[03:04:57.235] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:57.235] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:7:0) after 1m0s
[03:05:57.271] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:7:0)
[03:05:57.271] Timer tick, asking Buildbucket for the build status
[03:05:57.354] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:57.354] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:8:0) after 1m0s
[03:06:57.475] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:8:0)
[03:06:57.475] Timer tick, asking Buildbucket for the build status
[03:06:57.595] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:57.595] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:9:0) after 1m0s
[03:07:57.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:9:0)
[03:07:57.613] Timer tick, asking Buildbucket for the build status
[03:07:57.710] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:57.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:10:0) after 1m0s
[03:08:57.733] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:10:0)
[03:08:57.733] Timer tick, asking Buildbucket for the build status
[03:08:57.847] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.847] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:11:0) after 1m0s
[03:09:57.864] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:11:0)
[03:09:57.864] Timer tick, asking Buildbucket for the build status
[03:09:57.949] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:57.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:12:0) after 1m0s
[03:10:57.967] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:12:0)
[03:10:57.967] Timer tick, asking Buildbucket for the build status
[03:10:58.011] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:58.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:13:0) after 1m0s
[03:11:58.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:13:0)
[03:11:58.052] Timer tick, asking Buildbucket for the build status
[03:11:58.133] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:58.133] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:14:0) after 1m0s
[03:12:58.152] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:14:0)
[03:12:58.152] Timer tick, asking Buildbucket for the build status
[03:12:58.293] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:58.293] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:15:0) after 1m0s
[03:13:58.324] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:15:0)
[03:13:58.324] Timer tick, asking Buildbucket for the build status
[03:13:58.435] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:58.435] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:16:0) after 1m0s
[03:14:58.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:16:0)
[03:14:58.469] Timer tick, asking Buildbucket for the build status
[03:14:58.574] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:58.574] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:17:0) after 1m0s
[03:15:58.591] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:17:0)
[03:15:58.591] Timer tick, asking Buildbucket for the build status
[03:15:58.695] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.695] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:18:0) after 1m0s
[03:16:58.724] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:18:0)
[03:16:58.724] Timer tick, asking Buildbucket for the build status
[03:16:58.809] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:58.809] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:19:0) after 1m0s
[03:17:58.832] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:19:0)
[03:17:58.832] Timer tick, asking Buildbucket for the build status
[03:17:58.909] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:58.909] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:20:0) after 1m0s
[03:18:58.944] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:20:0)
[03:18:58.944] Timer tick, asking Buildbucket for the build status
[03:18:59.046] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:59.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:21:0) after 1m0s
[03:19:59.066] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:21:0)
[03:19:59.066] Timer tick, asking Buildbucket for the build status
[03:19:59.193] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:59.193] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:22:0) after 1m0s
[03:20:59.227] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:22:0)
[03:20:59.227] Timer tick, asking Buildbucket for the build status
[03:21:00.750] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:00.750] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:23:0) after 1m0s
[03:22:00.840] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:23:0)
[03:22:00.840] Timer tick, asking Buildbucket for the build status
[03:22:00.920] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:00.920] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:24:0) after 1m0s
[03:23:01.023] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:24:0)
[03:23:01.023] Timer tick, asking Buildbucket for the build status
[03:23:01.103] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:01.103] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:25:0) after 1m0s
[03:24:01.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:25:0)
[03:24:01.122] Timer tick, asking Buildbucket for the build status
[03:24:01.290] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:01.290] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:26:0) after 1m0s
[03:25:01.313] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:26:0)
[03:25:01.313] Timer tick, asking Buildbucket for the build status
[03:25:01.513] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:01.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:27:0) after 1m0s
[03:26:01.531] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:27:0)
[03:26:01.531] Timer tick, asking Buildbucket for the build status
[03:26:01.743] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:01.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:28:0) after 1m0s
[03:27:01.761] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:28:0)
[03:27:01.761] Timer tick, asking Buildbucket for the build status
[03:27:03.489] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:03.489] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:29:0) after 1m0s
[03:28:03.512] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:29:0)
[03:28:03.512] Timer tick, asking Buildbucket for the build status
[03:28:04.413] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:04.413] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:30:0) after 1m0s
[03:29:04.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:30:0)
[03:29:04.429] Timer tick, asking Buildbucket for the build status
[03:29:04.519] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:04.519] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:31:0) after 1m0s
[03:30:04.538] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:31:0)
[03:30:04.538] Timer tick, asking Buildbucket for the build status
[03:30:04.609] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:04.609] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:32:0) after 1m0s
[03:31:04.627] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:32:0)
[03:31:04.627] Timer tick, asking Buildbucket for the build status
[03:31:04.893] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:04.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:33:0) after 1m0s
[03:32:04.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:33:0)
[03:32:04.925] Timer tick, asking Buildbucket for the build status
[03:32:04.996] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:04.996] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:34:0) after 1m0s
[03:33:05.019] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:34:0)
[03:33:05.019] Timer tick, asking Buildbucket for the build status
[03:33:05.158] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:05.159] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:35:0) after 1m0s
[03:34:05.262] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:35:0)
[03:34:05.262] Timer tick, asking Buildbucket for the build status
[03:34:05.309] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:05.309] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:36:0) after 1m0s
[03:35:05.330] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:36:0)
[03:35:05.330] Timer tick, asking Buildbucket for the build status
[03:35:05.413] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:05.413] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:37:0) after 1m0s
[03:36:05.458] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:37:0)
[03:36:05.458] Timer tick, asking Buildbucket for the build status
[03:36:05.568] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:05.568] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:38:0) after 1m0s
[03:37:05.591] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:38:0)
[03:37:05.591] Timer tick, asking Buildbucket for the build status
[03:37:05.668] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:05.668] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:39:0) after 1m0s
[03:38:05.951] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:39:0)
[03:38:05.951] Timer tick, asking Buildbucket for the build status
[03:38:06.033] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:06.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:40:0) after 1m0s
[03:39:06.086] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:40:0)
[03:39:06.086] Timer tick, asking Buildbucket for the build status
[03:39:06.153] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:06.153] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:41:0) after 1m0s
[03:40:06.173] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:41:0)
[03:40:06.173] Timer tick, asking Buildbucket for the build status
[03:40:06.247] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:06.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:42:0) after 1m0s
[03:41:06.270] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:42:0)
[03:41:06.270] Timer tick, asking Buildbucket for the build status
[03:41:06.398] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:06.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:43:0) after 1m0s
[03:42:06.419] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:43:0)
[03:42:06.419] Timer tick, asking Buildbucket for the build status
[03:42:06.565] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:06.565] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:44:0) after 1m0s
[03:43:06.585] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:44:0)
[03:43:06.585] Timer tick, asking Buildbucket for the build status
[03:43:06.875] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:06.875] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:45:0) after 1m0s
[03:44:06.895] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:45:0)
[03:44:06.895] Timer tick, asking Buildbucket for the build status
[03:44:07.032] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:07.032] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:46:0) after 1m0s
[03:45:07.051] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:46:0)
[03:45:07.051] Timer tick, asking Buildbucket for the build status
[03:45:07.124] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:07.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:47:0) after 1m0s
[03:46:07.143] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:47:0)
[03:46:07.143] Timer tick, asking Buildbucket for the build status
[03:46:07.217] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:07.217] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:48:0) after 1m0s
[03:47:07.237] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:48:0)
[03:47:07.237] Timer tick, asking Buildbucket for the build status
[03:47:07.420] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:07.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:49:0) after 1m0s
[03:48:07.441] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:49:0)
[03:48:07.441] Timer tick, asking Buildbucket for the build status
[03:48:07.569] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:07.569] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:50:0) after 1m0s
[03:49:07.591] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:50:0)
[03:49:07.591] Timer tick, asking Buildbucket for the build status
[03:49:07.808] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:07.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:51:0) after 1m0s
[03:50:07.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:51:0)
[03:50:07.899] Timer tick, asking Buildbucket for the build status
[03:50:08.011] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:08.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:52:0) after 1m0s
[03:51:09.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:52:0)
[03:51:09.170] Timer tick, asking Buildbucket for the build status
[03:51:09.238] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:09.238] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:53:0) after 1m0s
[03:52:10.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:53:0)
[03:52:10.729] Timer tick, asking Buildbucket for the build status
[03:52:10.785] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:10.785] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:54:0) after 1m0s
[03:53:10.921] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:54:0)
[03:53:10.921] Timer tick, asking Buildbucket for the build status
[03:53:10.990] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:10.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:55:0) after 1m0s
[03:54:11.012] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:55:0)
[03:54:11.012] Timer tick, asking Buildbucket for the build status
[03:54:11.102] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:11.102] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:56:0) after 1m0s
[03:55:11.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:56:0)
[03:55:11.122] Timer tick, asking Buildbucket for the build status
[03:55:11.196] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:11.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:57:0) after 1m0s
[03:56:11.223] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:57:0)
[03:56:11.223] Timer tick, asking Buildbucket for the build status
[03:56:11.398] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:11.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:58:0) after 1m0s
[03:57:11.434] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:58:0)
[03:57:11.434] Timer tick, asking Buildbucket for the build status
[03:57:11.493] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:11.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:59:0) after 1m0s
[03:58:11.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:59:0)
[03:58:11.515] Timer tick, asking Buildbucket for the build status
[03:58:11.632] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:11.632] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:60:0) after 1m0s
[03:59:11.652] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:60:0)
[03:59:11.652] Timer tick, asking Buildbucket for the build status
[03:59:11.734] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:11.734] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:61:0) after 1m0s
[04:00:12.169] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:61:0)
[04:00:12.169] Timer tick, asking Buildbucket for the build status
[04:00:12.251] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:12.251] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:62:0) after 1m0s
[04:01:13.228] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:62:0)
[04:01:13.228] Timer tick, asking Buildbucket for the build status
[04:01:13.336] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:13.336] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:63:0) after 1m0s
[04:02:13.733] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:63:0)
[04:02:13.733] Timer tick, asking Buildbucket for the build status
[04:02:13.963] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:13.964] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:64:0) after 1m0s
[04:03:16.598] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:64:0)
[04:03:16.598] Timer tick, asking Buildbucket for the build status
[04:03:16.668] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:16.668] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:65:0) after 1m0s
[04:04:18.082] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:65:0)
[04:04:18.082] Timer tick, asking Buildbucket for the build status
[04:04:18.197] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:18.197] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:66:0) after 1m0s
[04:05:19.412] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:66:0)
[04:05:19.412] Timer tick, asking Buildbucket for the build status
[04:05:19.527] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:19.527] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:67:0) after 1m0s
[04:06:20.578] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:67:0)
[04:06:20.578] Timer tick, asking Buildbucket for the build status
[04:06:20.662] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:20.662] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:68:0) after 1m0s
[04:07:22.280] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:68:0)
[04:07:22.280] Timer tick, asking Buildbucket for the build status
[04:07:22.439] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:22.439] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:69:0) after 1m0s
[04:08:23.205] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:69:0)
[04:08:23.205] Timer tick, asking Buildbucket for the build status
[04:08:23.480] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:23.480] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:70:0) after 1m0s
[04:09:23.652] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:70:0)
[04:09:23.652] Timer tick, asking Buildbucket for the build status
[04:09:23.716] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:23.716] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:71:0) after 1m0s
[04:10:24.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:71:0)
[04:10:24.744] Timer tick, asking Buildbucket for the build status
[04:10:24.910] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:24.910] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:72:0) after 1m0s
[04:11:25.984] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:72:0)
[04:11:25.984] Timer tick, asking Buildbucket for the build status
[04:11:26.137] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:26.137] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:73:0) after 1m0s
[04:12:27.272] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:73:0)
[04:12:27.272] Timer tick, asking Buildbucket for the build status
[04:12:27.339] Build 8936077673404068992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:27.339] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101507735610658976:74:0) after 1m0s
[04:13:13.743] Received PubSub notification, asking Buildbucket for the build status
[04:13:13.849] Build 8936077673404068992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:13:13.849] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1536293587835746",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536289255671938",
"id": "8936077673404068992",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"bfbc8215d5482b4c804f42d5728d8d29f5ddd500\", \"root_solution_revision_timestamp\": 1536288530}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"chromium_codesearch\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936077673404068992/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"codesearch-gen-chromium-linux\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3769-3c22b45\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm1879-c4\"], \"pool\": [\"luci.infra.codesearch\"], \"caches\": [\"builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_clang_revision\": \"340925-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"bfbc8215d5482b4c804f42d5728d8d29f5ddd500\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24610}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1536288530, \"got_revision_cp\": \"refs/heads/master@{#589418}\", \"root_solution_revision\": \"bfbc8215d5482b4c804f42d5728d8d29f5ddd500\", \"buildername\": \"codesearch-gen-chromium-linux\", \"got_webrtc_revision\": \"ea8b6f95c7636a28c45c24420aa6d9e7255a0011\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"801719235b132b3bd53af35fba36dfe9238cf14f\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536289255671938, \"tags\": [\"builder:codesearch-gen-chromium-linux\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5627\", \"scheduler_invocation_id:9101507735610658976\", \"scheduler_job_id:infra/codesearch-gen-chromium-linux\", \"user_agent:luci-scheduler\", \"user_agent:recipe\"], \"bucket\": \"luci.infra.codesearch\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"infra\", \"id\": \"8936077673404068992\"}}, \"got_v8_revision\": \"e1220339a6c864b71394ad9f98537df0e55f3796\", \"got_v8_revision_cp\": \"refs/heads/7.1.54@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3483, \"path_config\": \"generic\", \"bot_id\": \"swarm1879-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536289314347706",
"status": "COMPLETED",
"status_changed_ts": "1536293588463758",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5627",
"scheduler_invocation_id:9101507735610658976",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"swarming_dimension:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.codesearch",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8936077673404068992",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936077673404068992/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5627",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101507735610658976",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:d35ad0202050590393072590ac52b8068d1c49f9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fcacb3ba3cfbb10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1536293588465297",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3483",
"utcnow_ts": "1536293593839367"
}
}
[04:13:13.849] Invocation finished in 1h12m19.666598924s with status SUCCEEDED