[03:12:49.157] New invocation is queued and will start shortly
[03:12:49.157] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[03:12:50.225] Starting the invocation (attempt 1)
[03:12:50.260] Ignoring gitiles_ref tag without the buildset tag
[03:12:50.260] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:50.260] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:50.260] Buildbucket request:
{
"requestId": "8946586173370895056",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8946586173370895056",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "8a78a0273a8d1a133e5d2b5b5d7daab6189dae10",
"codesearch_mirror_revision_timestamp": 1684022422,
"root_solution_revision": "a822c9eee265ed6256d678f10bf3c01f09b4f34a",
"root_solution_revision_timestamp": 1684021964
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17286",
"user_agent:recipe"
]
},
"id": "7d0f96f8-dd28-458f-9966-27588c11e33a",
"title": "codesearch-gen-chromium-initiator/17286"
}
]
},
"codesearch_mirror_revision": "8a78a0273a8d1a133e5d2b5b5d7daab6189dae10",
"codesearch_mirror_revision_timestamp": 1684022422,
"root_solution_revision": "a822c9eee265ed6256d678f10bf3c01f09b4f34a",
"root_solution_revision_timestamp": 1684021964
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946586173370895056"
},
{
"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": "17286"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:12:50.622] Scheduled build:
{
"id": "8781156111492057665",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11855,
"createdBy": "project:infra",
"createTime": "2023-05-14T03:12:50.324106038Z",
"updateTime": "2023-05-14T03:12:50.324106038Z",
"status": "SCHEDULED",
"input": {
}
}
[03:12:50.622] Task URL: https://cr-buildbucket.appspot.com/build/8781156111492057665
[03:12:50.622] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:2:0) after 2m30s
[03:13:52.345] Received PubSub notification, asking Buildbucket for the build status
[03:13:52.376] Build status: STARTED
[03:15:20.638] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:2:0)
[03:15:20.660] Build status: STARTED
[03:15:20.660] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:4:0) after 5m51s
[03:21:11.678] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:4:0)
[03:21:11.704] Build status: STARTED
[03:21:11.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:5:0) after 9m12s
[03:30:23.719] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:5:0)
[03:30:23.742] Build status: STARTED
[03:30:23.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:6:0) after 7m7s
[03:37:30.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:6:0)
[03:37:30.784] Build status: STARTED
[03:37:30.784] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:7:0) after 5m43s
[03:43:13.799] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:7:0)
[03:43:13.823] Build status: STARTED
[03:43:13.823] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:8:0) after 1m12s
[03:44:25.882] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:8:0)
[03:44:25.899] Build status: STARTED
[03:44:25.900] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:9:0) after 2m26s
[03:46:51.933] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:9:0)
[03:46:52.000] Build status: STARTED
[03:46:52.000] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:10:0) after 8m37s
[03:55:29.035] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:10:0)
[03:55:29.068] Build status: STARTED
[03:55:29.068] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:11:0) after 9m29s
[04:04:58.237] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:11:0)
[04:04:58.274] Build status: STARTED
[04:04:58.274] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:12:0) after 2m13s
[04:07:11.342] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:12:0)
[04:07:11.408] Build status: STARTED
[04:07:11.408] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:13:0) after 8m21s
[04:15:32.574] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:13:0)
[04:15:32.589] Build status: STARTED
[04:15:32.589] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:14:0) after 7m11s
[04:22:43.826] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:14:0)
[04:22:43.871] Build status: STARTED
[04:22:43.871] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:15:0) after 7m18s
[04:30:01.979] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:15:0)
[04:30:02.001] Build status: STARTED
[04:30:02.001] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:16:0) after 8m54s
[04:38:56.015] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:16:0)
[04:38:56.038] Build status: STARTED
[04:38:56.038] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:17:0) after 3m15s
[04:42:11.055] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:17:0)
[04:42:11.163] Build status: STARTED
[04:42:11.163] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:18:0) after 5m2s
[04:47:13.181] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:18:0)
[04:47:13.228] Build status: STARTED
[04:47:13.228] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:19:0) after 6m44s
[04:53:57.531] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:19:0)
[04:53:57.550] Build status: STARTED
[04:53:57.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:20:0) after 9m6s
[05:03:03.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:20:0)
[05:03:04.031] Build status: STARTED
[05:03:04.031] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:21:0) after 4m11s
[05:07:15.124] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:21:0)
[05:07:15.152] Build status: STARTED
[05:07:15.152] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:22:0) after 7m29s
[05:14:44.180] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:22:0)
[05:14:44.207] Build status: STARTED
[05:14:44.207] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:23:0) after 1m6s
[05:15:50.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:23:0)
[05:15:50.274] Build status: STARTED
[05:15:50.274] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:24:0) after 3m37s
[05:19:27.394] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:24:0)
[05:19:27.416] Build status: STARTED
[05:19:27.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:25:0) after 8m13s
[05:27:40.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:25:0)
[05:27:40.457] Build status: STARTED
[05:27:40.457] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:26:0) after 2m54s
[05:30:34.482] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:26:0)
[05:30:34.503] Build status: STARTED
[05:30:34.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:27:0) after 4m28s
[05:35:02.518] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:27:0)
[05:35:02.576] Build status: STARTED
[05:35:02.576] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:28:0) after 9m53s
[05:44:55.590] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:28:0)
[05:44:55.610] Build status: STARTED
[05:44:55.610] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:29:0) after 9m57s
[05:54:52.624] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:29:0)
[05:54:52.642] Build status: STARTED
[05:54:52.642] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:30:0) after 5m4s
[05:59:56.657] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:30:0)
[05:59:56.681] Build status: STARTED
[05:59:56.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:31:0) after 8m47s
[06:08:43.869] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:31:0)
[06:08:43.896] Build status: STARTED
[06:08:43.896] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:32:0) after 4m13s
[06:12:56.912] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:32:0)
[06:12:56.962] Build status: STARTED
[06:12:56.962] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:33:0) after 9m33s
[06:22:29.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:33:0)
[06:22:30.036] Build status: STARTED
[06:22:30.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:34:0) after 2m35s
[06:25:05.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:34:0)
[06:25:05.398] Build status: STARTED
[06:25:05.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:35:0) after 1m42s
[06:26:48.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:35:0)
[06:26:48.191] Build status: STARTED
[06:26:48.191] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:36:0) after 6m3s
[06:32:51.204] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:36:0)
[06:32:51.239] Build status: STARTED
[06:32:51.239] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:37:0) after 6m48s
[06:39:39.250] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:37:0)
[06:39:39.267] Build status: STARTED
[06:39:39.267] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:38:0) after 1m48s
[06:41:27.294] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:38:0)
[06:41:27.357] Build status: STARTED
[06:41:27.357] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:39:0) after 6m45s
[06:48:15.451] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:39:0)
[06:48:15.472] Build status: STARTED
[06:48:15.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8946586173370895056:40:0) after 5m46s
[06:53:06.495] Received PubSub notification, asking Buildbucket for the build status
[06:53:06.524] Build:
{
"id": "8781156111492057665",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11855,
"createdBy": "project:infra",
"createTime": "2023-05-14T03:12:50.324106038Z",
"startTime": "2023-05-14T03:13:22.777884Z",
"endTime": "2023-05-14T06:53:06.198304926Z",
"updateTime": "2023-05-14T06:53:06.198304926Z",
"status": "SUCCESS",
"input": {
}
}
[06:53:06.524] Invocation finished in 3h40m17.376734415s with status SUCCEEDED