[04:03:17.182] New invocation is queued and will start shortly
[04:03:17.182] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:03:18.334] Starting the invocation (attempt 1)
[04:03:18.360] Ignoring gitiles_ref tag without the buildset tag
[04:03:18.360] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:03:18.360] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:03:18.361] Buildbucket request:
{
"requestId": "8905633169438822768",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905633169438822768",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "c84e774a8125372effd9e3acc1cc448d39e4fb3c",
"codesearch_mirror_revision_timestamp": 1723089742,
"root_solution_revision": "f165a1b0aac185404c5fdb6b6479c392a3ed369f",
"root_solution_revision_timestamp": 1723089653
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:20001",
"user_agent:recipe"
]
},
"id": "9740f5f2-869a-4086-a332-b4828684d919",
"title": "codesearch-gen-chromium-initiator/20001"
}
]
},
"codesearch_mirror_revision": "c84e774a8125372effd9e3acc1cc448d39e4fb3c",
"codesearch_mirror_revision_timestamp": 1723089742,
"root_solution_revision": "f165a1b0aac185404c5fdb6b6479c392a3ed369f",
"root_solution_revision_timestamp": 1723089653
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905633169438822768"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-win"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "20001"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:03:18.832] Scheduled build:
{
"id": "8740203107489994673",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 14244,
"createdBy": "project:infra",
"createTime": "2024-08-08T04:03:18.420408330Z",
"updateTime": "2024-08-08T04:03:18.420408330Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[04:03:18.832] Task URL: https://cr-buildbucket.appspot.com/build/8740203107489994673
[04:03:18.832] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:2:0) after 7m25s
[04:03:19.181] Received PubSub notification, asking Buildbucket for the build status
[04:03:19.202] Build status: SCHEDULED
[04:03:26.080] Received PubSub notification, asking Buildbucket for the build status
[04:03:26.112] Build status: STARTED
[04:10:43.956] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:2:0)
[04:10:43.977] Build status: STARTED
[04:10:43.977] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:5:0) after 3m28s
[04:14:12.217] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:5:0)
[04:14:12.242] Build status: STARTED
[04:14:12.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:6:0) after 2m7s
[04:16:19.319] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:6:0)
[04:16:19.341] Build status: STARTED
[04:16:19.341] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:7:0) after 3m16s
[04:19:35.850] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:7:0)
[04:19:35.870] Build status: STARTED
[04:19:35.870] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:8:0) after 4m31s
[04:24:06.958] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:8:0)
[04:24:06.998] Build status: STARTED
[04:24:06.998] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:9:0) after 1m21s
[04:25:28.182] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:9:0)
[04:25:28.257] Build status: STARTED
[04:25:28.257] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:10:0) after 5m10s
[04:30:38.410] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:10:0)
[04:30:38.444] Build status: STARTED
[04:30:38.444] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:11:0) after 4m28s
[04:35:06.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:11:0)
[04:35:06.903] Build status: STARTED
[04:35:06.903] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:12:0) after 8m46s
[04:43:52.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:12:0)
[04:43:52.940] Build status: STARTED
[04:43:52.940] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:13:0) after 5m43s
[04:49:36.307] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:13:0)
[04:49:36.328] Build status: STARTED
[04:49:36.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:14:0) after 8m41s
[04:58:17.348] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:14:0)
[04:58:17.416] Build status: STARTED
[04:58:17.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:15:0) after 7m51s
[05:06:08.798] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:15:0)
[05:06:08.869] Build status: STARTED
[05:06:08.869] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:16:0) after 7m49s
[05:13:57.941] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:16:0)
[05:13:57.960] Build status: STARTED
[05:13:57.960] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:17:0) after 5m19s
[05:19:16.976] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:17:0)
[05:19:17.004] Build status: STARTED
[05:19:17.004] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:18:0) after 2m15s
[05:21:32.124] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:18:0)
[05:21:32.142] Build status: STARTED
[05:21:32.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:19:0) after 6m48s
[05:28:20.338] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:19:0)
[05:28:20.355] Build status: STARTED
[05:28:20.355] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:20:0) after 9m10s
[05:37:30.495] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:20:0)
[05:37:30.529] Build status: STARTED
[05:37:30.529] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:21:0) after 7m56s
[05:45:26.798] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:21:0)
[05:45:26.817] Build status: STARTED
[05:45:26.817] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:22:0) after 2m38s
[05:48:05.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:22:0)
[05:48:05.049] Build status: STARTED
[05:48:05.049] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:23:0) after 8m55s
[05:57:00.231] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:23:0)
[05:57:00.260] Build status: STARTED
[05:57:00.260] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:24:0) after 4m47s
[06:01:47.575] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:24:0)
[06:01:47.617] Build status: STARTED
[06:01:47.617] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:25:0) after 4m23s
[06:06:10.631] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:25:0)
[06:06:10.703] Build status: STARTED
[06:06:10.703] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:26:0) after 4m14s
[06:10:24.682] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:26:0)
[06:10:24.730] Build status: STARTED
[06:10:24.730] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:27:0) after 2m39s
[06:13:03.745] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:27:0)
[06:13:03.774] Build status: STARTED
[06:13:03.774] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:28:0) after 4m31s
[06:17:34.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:28:0)
[06:17:34.923] Build status: STARTED
[06:17:34.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:29:0) after 4m17s
[06:21:52.048] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:29:0)
[06:21:52.068] Build status: STARTED
[06:21:52.069] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:30:0) after 7m11s
[06:29:03.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:30:0)
[06:29:03.319] Build status: STARTED
[06:29:03.319] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:31:0) after 1m33s
[06:30:36.340] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:31:0)
[06:30:36.366] Build status: STARTED
[06:30:36.366] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:32:0) after 6m31s
[06:37:07.391] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:32:0)
[06:37:07.415] Build status: STARTED
[06:37:07.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:33:0) after 5m12s
[06:42:19.433] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:33:0)
[06:42:19.459] Build status: STARTED
[06:42:19.459] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:34:0) after 2m57s
[06:45:16.550] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:34:0)
[06:45:16.572] Build status: STARTED
[06:45:16.572] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:35:0) after 8m0s
[06:53:16.631] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:35:0)
[06:53:16.810] Build status: STARTED
[06:53:16.810] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:36:0) after 9m43s
[07:03:00.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:36:0)
[07:03:00.116] Build status: STARTED
[07:03:00.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:37:0) after 1m19s
[07:04:19.135] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:37:0)
[07:04:19.171] Build status: STARTED
[07:04:19.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:38:0) after 3m0s
[07:07:19.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:38:0)
[07:07:19.209] Build status: STARTED
[07:07:19.209] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:39:0) after 2m2s
[07:09:21.198] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:39:0)
[07:09:21.222] Build status: STARTED
[07:09:21.222] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:40:0) after 5m34s
[07:14:55.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:40:0)
[07:14:55.262] Build status: STARTED
[07:14:55.262] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:41:0) after 9m36s
[07:24:32.398] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:41:0)
[07:24:32.416] Build status: STARTED
[07:24:32.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:42:0) after 3m49s
[07:28:21.571] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:42:0)
[07:28:21.589] Build status: STARTED
[07:28:21.589] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:43:0) after 4m46s
[07:33:07.876] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:43:0)
[07:33:07.895] Build status: STARTED
[07:33:07.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:44:0) after 7m28s
[07:40:35.895] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:44:0)
[07:40:35.922] Build status: STARTED
[07:40:35.922] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:45:0) after 4m58s
[07:45:34.072] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:45:0)
[07:45:34.131] Build status: STARTED
[07:45:34.131] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:46:0) after 2m48s
[07:48:22.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:46:0)
[07:48:22.339] Build status: STARTED
[07:48:22.339] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:47:0) after 6m0s
[07:54:22.409] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:47:0)
[07:54:22.440] Build status: STARTED
[07:54:22.440] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8905633169438822768:48:0) after 4m30s
[07:58:09.543] Received PubSub notification, asking Buildbucket for the build status
[07:58:09.578] Build:
{
"id": "8740203107489994673",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 14244,
"createdBy": "project:infra",
"createTime": "2024-08-08T04:03:18.420408330Z",
"startTime": "2024-08-08T04:03:25.889793014Z",
"endTime": "2024-08-08T07:58:09.309992471Z",
"updateTime": "2024-08-08T07:58:09.309992471Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[07:58:09.578] Invocation finished in 3h54m52.400240458s with status SUCCEEDED