[00:29:04.454] New invocation is queued and will start shortly
[00:29:04.454] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[00:29:05.531] Starting the invocation (attempt 1)
[00:29:05.563] Ignoring gitiles_ref tag without the buildset tag
[00:29:05.563] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:29:05.564] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:29:05.564] Buildbucket request:
{
"requestId": "8953119456897705024",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8953119456897705024",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "3a6cc0c3efa7f37d52828cdb75c59dbf91563a8a",
"codesearch_mirror_revision_timestamp": 1677786604,
"root_solution_revision": "9c0494d223b9c30f49afdf139b7231a25869809a",
"root_solution_revision_timestamp": 1677786435
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:16853",
"user_agent:recipe"
]
},
"id": "3029e927-19c6-4395-97da-7ddc7fc507bc",
"title": "codesearch-gen-chromium-initiator/16853"
},
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "976dcf3e88ccd0e6a9aa3750b9bc43ddded631ec",
"codesearch_mirror_revision_timestamp": 1677801533,
"root_solution_revision": "e023066c1c39fbd25cfdf66825039a1bf03bb6aa",
"root_solution_revision_timestamp": 1677801283
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:16854",
"user_agent:recipe"
]
},
"id": "d24f4396-d81e-43e2-9a0b-d93ff2df1a5d",
"title": "codesearch-gen-chromium-initiator/16854"
}
]
},
"codesearch_mirror_revision": "976dcf3e88ccd0e6a9aa3750b9bc43ddded631ec",
"codesearch_mirror_revision_timestamp": 1677801533,
"root_solution_revision": "e023066c1c39fbd25cfdf66825039a1bf03bb6aa",
"root_solution_revision_timestamp": 1677801283
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8953119456897705024"
},
{
"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": "16854"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:29:06.135] Scheduled build:
{
"id": "8787689394925085185",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11485,
"createdBy": "project:infra",
"createTime": "2023-03-03T00:29:05.712473480Z",
"updateTime": "2023-03-03T00:29:05.712473480Z",
"status": "SCHEDULED",
"input": {
}
}
[00:29:06.135] Task URL: https://cr-buildbucket.appspot.com/build/8787689394925085185
[00:29:06.135] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:2:0) after 1m57s
[00:29:47.919] Received PubSub notification, asking Buildbucket for the build status
[00:29:47.975] Build status: STARTED
[00:31:03.293] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:2:0)
[00:31:03.341] Build status: STARTED
[00:31:03.341] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:4:0) after 2m8s
[00:33:11.560] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:4:0)
[00:33:11.582] Build status: STARTED
[00:33:11.582] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:5:0) after 4m59s
[00:38:10.677] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:5:0)
[00:38:11.017] Build status: STARTED
[00:38:11.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:6:0) after 6m28s
[00:44:39.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:6:0)
[00:44:39.149] Build status: STARTED
[00:44:39.149] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:7:0) after 5m10s
[00:49:49.312] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:7:0)
[00:49:49.408] Build status: STARTED
[00:49:49.408] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:8:0) after 1m50s
[00:51:39.699] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:8:0)
[00:51:39.723] Build status: STARTED
[00:51:39.723] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:9:0) after 4m42s
[00:56:21.855] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:9:0)
[00:56:21.969] Build status: STARTED
[00:56:21.969] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:10:0) after 7m40s
[01:04:02.090] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:10:0)
[01:04:02.140] Build status: STARTED
[01:04:02.140] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:11:0) after 6m27s
[01:10:29.151] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:11:0)
[01:10:29.173] Build status: STARTED
[01:10:29.173] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:12:0) after 2m49s
[01:13:18.193] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:12:0)
[01:13:18.213] Build status: STARTED
[01:13:18.213] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:13:0) after 4m31s
[01:17:49.233] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:13:0)
[01:17:49.256] Build status: STARTED
[01:17:49.256] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:14:0) after 1m12s
[01:19:01.265] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:14:0)
[01:19:01.299] Build status: STARTED
[01:19:01.299] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:15:0) after 1m57s
[01:20:58.278] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:15:0)
[01:20:58.311] Build status: STARTED
[01:20:58.311] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:16:0) after 1m50s
[01:22:48.328] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:16:0)
[01:22:48.352] Build status: STARTED
[01:22:48.352] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:17:0) after 9m24s
[01:32:12.379] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:17:0)
[01:32:12.428] Build status: STARTED
[01:32:12.428] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:18:0) after 2m35s
[01:34:47.710] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:18:0)
[01:34:47.741] Build status: STARTED
[01:34:47.741] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:19:0) after 5m3s
[01:39:50.973] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:19:0)
[01:39:50.994] Build status: STARTED
[01:39:50.994] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:20:0) after 6m0s
[01:45:51.446] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:20:0)
[01:45:51.476] Build status: STARTED
[01:45:51.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:21:0) after 5m8s
[01:50:59.574] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:21:0)
[01:50:59.630] Build status: STARTED
[01:50:59.630] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:22:0) after 8m40s
[01:59:39.961] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:22:0)
[01:59:39.994] Build status: STARTED
[01:59:39.994] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:23:0) after 8m43s
[02:08:23.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:23:0)
[02:08:23.670] Build status: STARTED
[02:08:23.670] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:24:0) after 1m13s
[02:09:36.712] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:24:0)
[02:09:36.737] Build status: STARTED
[02:09:36.737] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:25:0) after 5m53s
[02:15:30.163] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:25:0)
[02:15:30.184] Build status: STARTED
[02:15:30.184] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:26:0) after 3m35s
[02:19:05.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:26:0)
[02:19:05.234] Build status: STARTED
[02:19:05.234] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:27:0) after 5m58s
[02:25:03.425] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:27:0)
[02:25:03.465] Build status: STARTED
[02:25:03.465] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:28:0) after 8m30s
[02:33:33.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:28:0)
[02:33:33.530] Build status: STARTED
[02:33:33.530] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:29:0) after 4m57s
[02:38:30.821] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:29:0)
[02:38:30.845] Build status: STARTED
[02:38:30.845] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:30:0) after 6m34s
[02:45:05.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:30:0)
[02:45:05.121] Build status: STARTED
[02:45:05.121] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:31:0) after 8m19s
[02:53:24.138] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:31:0)
[02:53:24.161] Build status: STARTED
[02:53:24.161] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:32:0) after 8m47s
[03:02:11.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:32:0)
[03:02:11.221] Build status: STARTED
[03:02:11.221] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:33:0) after 4m50s
[03:07:01.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:33:0)
[03:07:01.279] Build status: STARTED
[03:07:01.280] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:34:0) after 4m17s
[03:11:19.012] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:34:0)
[03:11:19.291] Build status: STARTED
[03:11:19.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:35:0) after 2m32s
[03:13:51.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:35:0)
[03:13:51.505] Build status: STARTED
[03:13:51.505] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:36:0) after 6m40s
[03:20:31.547] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:36:0)
[03:20:31.592] Build status: STARTED
[03:20:31.592] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:37:0) after 6m45s
[03:27:16.615] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:37:0)
[03:27:16.639] Build status: STARTED
[03:27:16.639] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:38:0) after 9m16s
[03:36:32.755] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:38:0)
[03:36:32.844] Build status: STARTED
[03:36:32.844] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:39:0) after 9m11s
[03:45:44.004] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:39:0)
[03:45:44.035] Build status: STARTED
[03:45:44.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:40:0) after 4m33s
[03:50:17.158] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:40:0)
[03:50:17.187] Build status: STARTED
[03:50:17.187] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:41:0) after 2m49s
[03:53:06.213] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:41:0)
[03:53:06.236] Build status: STARTED
[03:53:06.236] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:42:0) after 8m38s
[04:01:44.444] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:42:0)
[04:01:44.464] Build status: STARTED
[04:01:44.464] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:43:0) after 8m12s
[04:09:56.488] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:43:0)
[04:09:56.509] Build status: STARTED
[04:09:56.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:44:0) after 8m44s
[04:18:40.537] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:44:0)
[04:18:40.571] Build status: STARTED
[04:18:40.571] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:45:0) after 4m59s
[04:23:39.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:45:0)
[04:23:39.609] Build status: STARTED
[04:23:39.609] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:46:0) after 1m13s
[04:24:52.640] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:46:0)
[04:24:52.685] Build status: STARTED
[04:24:52.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:47:0) after 4m5s
[04:28:57.752] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:47:0)
[04:28:57.784] Build status: STARTED
[04:28:57.784] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:48:0) after 1m35s
[04:30:32.900] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:48:0)
[04:30:32.960] Build status: STARTED
[04:30:32.960] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:49:0) after 2m59s
[04:33:32.009] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:49:0)
[04:33:32.073] Build status: STARTED
[04:33:32.073] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:50:0) after 8m0s
[04:41:32.092] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:50:0)
[04:41:32.192] Build status: STARTED
[04:41:32.192] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:51:0) after 1m16s
[04:42:48.291] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:51:0)
[04:42:48.328] Build status: STARTED
[04:42:48.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:52:0) after 5m46s
[04:48:34.434] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:52:0)
[04:48:34.461] Build status: STARTED
[04:48:34.461] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:53:0) after 4m41s
[04:53:15.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:53:0)
[04:53:15.576] Build status: STARTED
[04:53:15.576] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:54:0) after 3m37s
[04:56:52.948] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:54:0)
[04:56:52.982] Build status: STARTED
[04:56:52.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:55:0) after 1m40s
[04:58:33.567] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:55:0)
[04:58:33.591] Build status: STARTED
[04:58:33.591] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:56:0) after 3m26s
[05:01:59.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:56:0)
[05:01:59.732] Build status: STARTED
[05:01:59.732] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:57:0) after 7m32s
[05:09:31.989] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:57:0)
[05:09:32.023] Build status: STARTED
[05:09:32.023] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:58:0) after 8m27s
[05:17:59.097] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:58:0)
[05:17:59.167] Build status: STARTED
[05:17:59.167] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:59:0) after 9m25s
[05:27:24.259] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:59:0)
[05:27:24.289] Build status: STARTED
[05:27:24.289] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8953119456897705024:60:0) after 8m34s
[05:32:21.553] Received PubSub notification, asking Buildbucket for the build status
[05:32:21.620] Build:
{
"id": "8787689394925085185",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11485,
"createdBy": "project:infra",
"createTime": "2023-03-03T00:29:05.712473480Z",
"startTime": "2023-03-03T00:29:47.423767Z",
"endTime": "2023-03-03T05:32:21.248546138Z",
"updateTime": "2023-03-03T05:32:21.248546138Z",
"status": "SUCCESS",
"input": {
}
}
[05:32:21.620] Invocation finished in 5h3m17.173923535s with status SUCCEEDED