[04:02:58.691] New invocation is queued and will start shortly
[04:02:58.691] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:02:59.794] Starting the invocation (attempt 1)
[04:02:59.825] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:02:59.825] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:02:59.825] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9017611039310390272",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"codesearch_mirror_revision\":\"189426bdd87ea434c5bde3f141abf81c2323f43d\",\"codesearch_mirror_revision_timestamp\":1616298751,\"root_solution_revision\":\"33fd51696b0a6e84ba747c923f43fd2c3dab5fa6\",\"root_solution_revision_timestamp\":1616298659},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:12583\",\"user_agent:recipe\"]},\"id\":\"35632dfb-d1d0-463d-b5e6-f7891db3e5a4\",\"title\":\"codesearch-gen-chromium-initiator/12583\"}]},\"codesearch_mirror_revision\":\"189426bdd87ea434c5bde3f141abf81c2323f43d\",\"codesearch_mirror_revision_timestamp\":1616298751,\"root_solution_revision\":\"33fd51696b0a6e84ba747c923f43fd2c3dab5fa6\",\"root_solution_revision_timestamp\":1616298659}}",
"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:9017611039310390272",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:12583",
"user_agent:recipe"
]
}
[04:03:01.372] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1616299379897655",
"id": "8852180977383317648",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"189426bdd87ea434c5bde3f141abf81c2323f43d\", \"codesearch_mirror_revision_timestamp\": 1616298751.0, \"root_solution_revision\": \"33fd51696b0a6e84ba747c923f43fd2c3dab5fa6\", \"root_solution_revision_timestamp\": 1616298659.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:12583\", \"user_agent:recipe\"]}, \"id\": \"35632dfb-d1d0-463d-b5e6-f7891db3e5a4\", \"title\": \"codesearch-gen-chromium-initiator/12583\"}]}, \"codesearch_mirror_revision\": \"189426bdd87ea434c5bde3f141abf81c2323f43d\", \"codesearch_mirror_revision_timestamp\": 1616298751.0, \"root_solution_revision\": \"33fd51696b0a6e84ba747c923f43fd2c3dab5fa6\", \"root_solution_revision_timestamp\": 1616298659.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616299380266867",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/7303",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:12583",
"scheduler_invocation_id:9017611039310390272",
"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/8852180977383317648/+/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": "1616299380266982",
"url": "https://ci.chromium.org/b/8852180977383317648",
"utcnow_ts": "1616299381365668"
}
}
[04:03:01.372] Task URL: https://ci.chromium.org/b/8852180977383317648
[04:03:01.372] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:2:0) after 1m0s
[04:03:47.080] Received PubSub notification, asking Buildbucket for the build status
[04:03:47.180] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:01.397] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:2:0)
[04:04:01.397] Timer tick, asking Buildbucket for the build status
[04:04:01.496] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:01.496] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:4:0) after 1m0s
[04:05:01.614] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:4:0)
[04:05:01.614] Timer tick, asking Buildbucket for the build status
[04:05:01.812] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:01.812] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:5:0) after 1m0s
[04:06:02.011] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:5:0)
[04:06:02.011] Timer tick, asking Buildbucket for the build status
[04:06:02.186] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:02.186] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:6:0) after 1m0s
[04:07:04.319] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:6:0)
[04:07:04.319] Timer tick, asking Buildbucket for the build status
[04:07:04.404] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:04.404] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:7:0) after 1m0s
[04:08:04.604] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:7:0)
[04:08:04.604] Timer tick, asking Buildbucket for the build status
[04:08:04.679] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:04.679] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:8:0) after 1m0s
[04:09:04.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:8:0)
[04:09:04.726] Timer tick, asking Buildbucket for the build status
[04:09:04.920] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:04.920] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:9:0) after 1m0s
[04:10:04.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:9:0)
[04:10:04.992] Build status: STARTED
[04:10:04.992] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:10:0) after 2m33s
[04:12:38.010] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:10:0)
[04:12:38.039] Build status: STARTED
[04:12:38.039] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:11:0) after 5m13s
[04:17:51.067] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:11:0)
[04:17:51.067] Timer tick, asking Buildbucket for the build status
[04:17:51.208] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:51.208] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:12:0) after 1m0s
[04:18:51.390] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:12:0)
[04:18:51.390] Timer tick, asking Buildbucket for the build status
[04:18:51.592] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:51.592] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:13:0) after 1m0s
[04:19:51.582] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:13:0)
[04:19:51.605] Build status: STARTED
[04:19:51.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:14:0) after 3m50s
[04:23:41.831] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:14:0)
[04:23:41.831] Timer tick, asking Buildbucket for the build status
[04:23:41.903] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:41.903] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:15:0) after 1m0s
[04:24:42.237] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:15:0)
[04:24:42.261] Build status: STARTED
[04:24:42.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:16:0) after 4m2s
[04:28:44.296] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:16:0)
[04:28:44.423] Build status: STARTED
[04:28:44.423] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:17:0) after 2m3s
[04:30:47.572] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:17:0)
[04:30:47.598] Build status: STARTED
[04:30:47.598] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:18:0) after 8m21s
[04:39:08.822] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:18:0)
[04:39:08.822] Timer tick, asking Buildbucket for the build status
[04:39:08.911] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:08.911] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:19:0) after 1m0s
[04:40:08.926] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:19:0)
[04:40:08.926] Timer tick, asking Buildbucket for the build status
[04:40:08.993] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:08.993] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:20:0) after 1m0s
[04:41:09.112] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:20:0)
[04:41:09.142] Build status: STARTED
[04:41:09.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:21:0) after 7m50s
[04:48:59.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:21:0)
[04:48:59.406] Timer tick, asking Buildbucket for the build status
[04:48:59.478] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:59.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:22:0) after 1m0s
[04:49:59.636] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:22:0)
[04:49:59.636] Timer tick, asking Buildbucket for the build status
[04:49:59.862] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:59.862] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:23:0) after 1m0s
[04:50:59.912] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:23:0)
[04:50:59.912] Timer tick, asking Buildbucket for the build status
[04:50:59.984] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:59.984] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:24:0) after 1m0s
[04:52:00.057] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:24:0)
[04:52:00.057] Timer tick, asking Buildbucket for the build status
[04:52:00.135] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:00.135] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:25:0) after 1m0s
[04:53:00.261] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:25:0)
[04:53:00.299] Build status: STARTED
[04:53:00.300] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:26:0) after 8m20s
[05:01:20.462] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:26:0)
[05:01:20.462] Timer tick, asking Buildbucket for the build status
[05:01:20.566] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:20.566] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:27:0) after 1m0s
[05:02:20.588] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:27:0)
[05:02:20.619] Build status: STARTED
[05:02:20.619] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:28:0) after 7m11s
[05:09:31.650] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:28:0)
[05:09:31.650] Timer tick, asking Buildbucket for the build status
[05:09:31.746] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:29:0) after 1m0s
[05:10:31.767] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:29:0)
[05:10:31.767] Timer tick, asking Buildbucket for the build status
[05:10:31.904] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:31.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:30:0) after 1m0s
[05:11:31.927] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:30:0)
[05:11:31.927] Timer tick, asking Buildbucket for the build status
[05:11:32.113] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:32.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:31:0) after 1m0s
[05:12:32.171] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:31:0)
[05:12:32.171] Timer tick, asking Buildbucket for the build status
[05:12:32.239] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:32.239] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:32:0) after 1m0s
[05:13:32.262] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:32:0)
[05:13:32.262] Timer tick, asking Buildbucket for the build status
[05:13:32.730] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.730] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:33:0) after 1m0s
[05:14:32.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:33:0)
[05:14:32.812] Timer tick, asking Buildbucket for the build status
[05:14:33.033] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:33.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:34:0) after 1m0s
[05:15:33.144] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:34:0)
[05:15:33.144] Timer tick, asking Buildbucket for the build status
[05:15:33.202] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:33.202] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:35:0) after 1m0s
[05:16:33.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:35:0)
[05:16:33.271] Build status: STARTED
[05:16:33.271] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:36:0) after 2m10s
[05:18:43.304] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:36:0)
[05:18:43.304] Timer tick, asking Buildbucket for the build status
[05:18:43.385] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:43.385] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:37:0) after 1m0s
[05:19:43.560] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:37:0)
[05:19:43.560] Timer tick, asking Buildbucket for the build status
[05:19:43.634] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:43.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:38:0) after 1m0s
[05:20:43.865] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:38:0)
[05:20:43.865] Timer tick, asking Buildbucket for the build status
[05:20:44.028] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.028] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:39:0) after 1m0s
[05:21:44.158] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:39:0)
[05:21:44.158] Timer tick, asking Buildbucket for the build status
[05:21:44.238] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:44.238] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:40:0) after 1m0s
[05:22:44.387] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:40:0)
[05:22:44.420] Build status: STARTED
[05:22:44.420] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:41:0) after 3m53s
[05:26:37.541] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:41:0)
[05:26:37.541] Timer tick, asking Buildbucket for the build status
[05:26:37.616] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:37.616] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:42:0) after 1m0s
[05:27:37.638] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:42:0)
[05:27:37.661] Build status: STARTED
[05:27:37.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:43:0) after 9m47s
[05:37:24.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:43:0)
[05:37:24.776] Build status: STARTED
[05:37:24.776] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:44:0) after 3m9s
[05:40:33.897] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:44:0)
[05:40:33.927] Build status: STARTED
[05:40:33.927] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:45:0) after 7m20s
[05:47:53.973] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:45:0)
[05:47:54.031] Build status: STARTED
[05:47:54.031] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:46:0) after 9m31s
[05:57:25.121] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:46:0)
[05:57:25.151] Build status: STARTED
[05:57:25.151] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:47:0) after 7m27s
[06:04:52.192] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:47:0)
[06:04:52.192] Timer tick, asking Buildbucket for the build status
[06:04:52.357] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:52.357] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:48:0) after 1m0s
[06:05:52.425] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:48:0)
[06:05:52.454] Build status: STARTED
[06:05:52.454] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:49:0) after 3m24s
[06:09:16.472] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:49:0)
[06:09:16.502] Build status: STARTED
[06:09:16.502] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:50:0) after 7m52s
[06:17:08.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:50:0)
[06:17:08.586] Build status: STARTED
[06:17:08.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:51:0) after 5m50s
[06:22:58.612] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:51:0)
[06:22:58.612] Timer tick, asking Buildbucket for the build status
[06:22:58.808] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:58.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:52:0) after 1m0s
[06:23:58.824] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:52:0)
[06:23:58.849] Build status: STARTED
[06:23:58.849] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:53:0) after 5m49s
[06:29:47.870] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:53:0)
[06:29:47.870] Timer tick, asking Buildbucket for the build status
[06:29:48.512] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:48.512] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:54:0) after 1m0s
[06:30:48.528] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:54:0)
[06:30:48.528] Timer tick, asking Buildbucket for the build status
[06:30:48.605] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:48.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:55:0) after 1m0s
[06:31:48.624] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:55:0)
[06:31:48.624] Timer tick, asking Buildbucket for the build status
[06:31:48.694] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:48.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:56:0) after 1m0s
[06:32:48.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:56:0)
[06:32:48.714] Timer tick, asking Buildbucket for the build status
[06:32:48.777] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:48.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:57:0) after 1m0s
[06:33:48.830] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:57:0)
[06:33:48.854] Build status: STARTED
[06:33:48.854] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:58:0) after 9m32s
[06:43:21.117] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:58:0)
[06:43:21.117] Timer tick, asking Buildbucket for the build status
[06:43:21.211] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:21.211] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:59:0) after 1m0s
[06:44:21.330] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:59:0)
[06:44:21.361] Build status: STARTED
[06:44:21.361] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:60:0) after 7m42s
[06:52:03.380] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:60:0)
[06:52:03.406] Build status: STARTED
[06:52:03.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:61:0) after 2m2s
[06:54:05.493] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:61:0)
[06:54:05.493] Timer tick, asking Buildbucket for the build status
[06:54:05.694] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:05.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:62:0) after 1m0s
[06:55:05.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:62:0)
[06:55:05.777] Timer tick, asking Buildbucket for the build status
[06:55:05.932] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:05.932] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:63:0) after 1m0s
[06:56:05.970] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:63:0)
[06:56:06.005] Build status: STARTED
[06:56:06.005] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:64:0) after 6m37s
[07:02:43.031] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:64:0)
[07:02:43.031] Timer tick, asking Buildbucket for the build status
[07:02:43.215] Build 8852180977383317648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:43.215] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:65:0) after 1m0s
[07:03:43.236] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:65:0)
[07:03:43.265] Build status: STARTED
[07:03:43.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9017611039310390272:66:0) after 6m9s
[07:07:10.669] Received PubSub notification, asking Buildbucket for the build status
[07:07:10.699] Build:
{
"id": "8852180977383317648",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 7303,
"createdBy": "project:infra",
"createTime": "2021-03-21T04:02:59.897655Z",
"startTime": "2021-03-21T04:03:39.638033Z",
"endTime": "2021-03-21T07:07:10.351754624Z",
"updateTime": "2021-03-21T07:07:10.352199192Z",
"status": "SUCCESS",
"input": {
}
}
[07:07:10.699] Invocation finished in 3h4m12.022134997s with status SUCCEEDED