[08:03:00.526] New invocation is queued and will start shortly
[08:03:00.526] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[08:03:01.640] Starting the invocation (attempt 1)
[08:03:01.676] Ignoring gitiles_ref tag without the buildset tag
[08:03:01.676] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:01.678] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:01.678] Buildbucket request:
{
"requestId": "8914587187090666448",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914587187090666448",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "33ef0d86830a0702c7e38b6db1c9c95164884547",
"codesearch_mirror_revision_timestamp": 1714550307,
"root_solution_revision": "bc4f0a08ba8d4453fc183d3ef4d59889a3b1cdde",
"root_solution_revision_timestamp": 1714549974
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:19407",
"user_agent:recipe"
]
},
"id": "f5e6d5f9-cce4-4888-b1c3-8d440e092f4f",
"title": "codesearch-gen-chromium-initiator/19407"
}
]
},
"codesearch_mirror_revision": "33ef0d86830a0702c7e38b6db1c9c95164884547",
"codesearch_mirror_revision_timestamp": 1714550307,
"root_solution_revision": "bc4f0a08ba8d4453fc183d3ef4d59889a3b1cdde",
"root_solution_revision_timestamp": 1714549974
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914587187090666448"
},
{
"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": "19407"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:03:02.295] Scheduled build:
{
"id": "8749157125135897809",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13651,
"createdBy": "project:infra",
"createTime": "2024-05-01T08:03:01.763501158Z",
"updateTime": "2024-05-01T08:03:01.763501158Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[08:03:02.295] Task URL: https://cr-buildbucket.appspot.com/build/8749157125135897809
[08:03:02.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:2:0) after 8m52s
[08:03:03.137] Received PubSub notification, asking Buildbucket for the build status
[08:03:03.167] Build status: SCHEDULED
[08:03:10.289] Received PubSub notification, asking Buildbucket for the build status
[08:03:10.314] Build status: STARTED
[08:11:54.319] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:2:0)
[08:11:54.362] Build status: STARTED
[08:11:54.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:5:0) after 1m44s
[08:13:38.477] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:5:0)
[08:13:38.512] Build status: STARTED
[08:13:38.512] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:6:0) after 2m55s
[08:16:33.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:6:0)
[08:16:33.701] Build status: STARTED
[08:16:33.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:7:0) after 9m7s
[08:25:40.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:7:0)
[08:25:40.751] Build status: STARTED
[08:25:40.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:8:0) after 1m42s
[08:27:22.795] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:8:0)
[08:27:22.848] Build status: STARTED
[08:27:22.848] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:9:0) after 5m27s
[08:32:50.291] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:9:0)
[08:32:50.355] Build status: STARTED
[08:32:50.355] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:10:0) after 5m4s
[08:37:54.478] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:10:0)
[08:37:54.549] Build status: STARTED
[08:37:54.549] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:11:0) after 8m6s
[08:46:00.691] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:11:0)
[08:46:00.710] Build status: STARTED
[08:46:00.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:12:0) after 8m35s
[08:54:35.825] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:12:0)
[08:54:35.913] Build status: STARTED
[08:54:35.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:13:0) after 4m0s
[08:58:36.041] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:13:0)
[08:58:36.117] Build status: STARTED
[08:58:36.117] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:14:0) after 6m47s
[09:05:23.134] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:14:0)
[09:05:23.182] Build status: STARTED
[09:05:23.182] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:15:0) after 2m15s
[09:07:38.206] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:15:0)
[09:07:38.226] Build status: STARTED
[09:07:38.226] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:16:0) after 4m27s
[09:12:05.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:16:0)
[09:12:05.455] Build status: STARTED
[09:12:05.455] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:17:0) after 1m45s
[09:13:50.506] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:17:0)
[09:13:50.597] Build status: STARTED
[09:13:50.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:18:0) after 8m43s
[09:22:33.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:18:0)
[09:22:33.805] Build status: STARTED
[09:22:33.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:19:0) after 5m56s
[09:28:30.053] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:19:0)
[09:28:30.081] Build status: STARTED
[09:28:30.081] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:20:0) after 1m5s
[09:29:35.396] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:20:0)
[09:29:35.417] Build status: STARTED
[09:29:35.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:21:0) after 2m17s
[09:31:52.537] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:21:0)
[09:31:52.567] Build status: STARTED
[09:31:52.567] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:22:0) after 7m38s
[09:39:30.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:22:0)
[09:39:30.615] Build status: STARTED
[09:39:30.615] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:23:0) after 7m26s
[09:46:56.745] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:23:0)
[09:46:56.785] Build status: STARTED
[09:46:56.785] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:24:0) after 3m28s
[09:50:24.903] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:24:0)
[09:50:24.949] Build status: STARTED
[09:50:24.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:25:0) after 5m20s
[09:55:45.056] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:25:0)
[09:55:45.091] Build status: STARTED
[09:55:45.091] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:26:0) after 7m56s
[10:03:41.114] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:26:0)
[10:03:41.370] Build status: STARTED
[10:03:41.371] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:27:0) after 4m53s
[10:08:34.390] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:27:0)
[10:08:34.411] Build status: STARTED
[10:08:34.411] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:28:0) after 2m9s
[10:10:43.534] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:28:0)
[10:10:43.561] Build status: STARTED
[10:10:43.561] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:29:0) after 6m35s
[10:17:18.659] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:29:0)
[10:17:18.747] Build status: STARTED
[10:17:18.747] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:30:0) after 4m4s
[10:21:22.763] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:30:0)
[10:21:22.792] Build status: STARTED
[10:21:22.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:31:0) after 2m13s
[10:23:35.991] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:31:0)
[10:23:36.016] Build status: STARTED
[10:23:36.016] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:32:0) after 2m33s
[10:26:09.161] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:32:0)
[10:26:09.234] Build status: STARTED
[10:26:09.234] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:33:0) after 3m21s
[10:29:30.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:33:0)
[10:29:30.411] Build status: STARTED
[10:29:30.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:34:0) after 5m24s
[10:34:54.501] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:34:0)
[10:34:54.591] Build status: STARTED
[10:34:54.591] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:35:0) after 9m49s
[10:44:43.618] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:35:0)
[10:44:43.638] Build status: STARTED
[10:44:43.638] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:36:0) after 2m6s
[10:46:49.657] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:36:0)
[10:46:49.704] Build status: STARTED
[10:46:49.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:37:0) after 1m4s
[10:47:53.689] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:37:0)
[10:47:53.722] Build status: STARTED
[10:47:53.722] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:38:0) after 5m34s
[10:53:27.904] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:38:0)
[10:53:28.021] Build status: STARTED
[10:53:28.021] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:39:0) after 2m1s
[10:55:29.056] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:39:0)
[10:55:29.146] Build status: STARTED
[10:55:29.146] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:40:0) after 5m15s
[11:00:44.164] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:40:0)
[11:00:44.200] Build status: STARTED
[11:00:44.200] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:41:0) after 5m58s
[11:06:42.351] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:41:0)
[11:06:42.374] Build status: STARTED
[11:06:42.374] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914587187090666448:42:0) after 6m29s
[11:08:20.648] Received PubSub notification, asking Buildbucket for the build status
[11:08:20.670] Build:
{
"id": "8749157125135897809",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13651,
"createdBy": "project:infra",
"createTime": "2024-05-01T08:03:01.763501158Z",
"startTime": "2024-05-01T08:03:09.975880861Z",
"endTime": "2024-05-01T11:08:20.362359112Z",
"updateTime": "2024-05-01T11:08:20.362359112Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[11:08:20.670] Invocation finished in 3h5m20.154625429s with status SUCCEEDED