[22:38:39.695] New invocation is queued and will start shortly
[22:38:39.695] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[22:38:40.749] Starting the invocation (attempt 1)
[22:38:40.777] Ignoring gitiles_ref tag without the buildset tag
[22:38:40.777] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:38:40.777] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:38:40.778] Buildbucket request:
{
"requestId": "8931926713332897696",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8931926713332897696",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "45374f245c9578d67a420eae762d8c3b81d2761a",
"codesearch_mirror_revision_timestamp": 1697984979,
"root_solution_revision": "0f4a1bb2aee4a225c8568a0786662b310a548a86",
"root_solution_revision_timestamp": 1697983371
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:18256",
"user_agent:recipe"
]
},
"id": "6fca8ea8-70e7-4ec3-971e-51ba74eb54f7",
"title": "codesearch-gen-chromium-initiator/18256"
},
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "bb71120e7dc82c76a99ba3e870569d0d8b695571",
"codesearch_mirror_revision_timestamp": 1697996685,
"root_solution_revision": "b4877d9c506f5575735ff9b0582a15a7062f9f9e",
"root_solution_revision_timestamp": 1697996393
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:18257",
"user_agent:recipe"
]
},
"id": "7765d181-12c2-4516-b93c-ecb8dce4a174",
"title": "codesearch-gen-chromium-initiator/18257"
}
]
},
"codesearch_mirror_revision": "bb71120e7dc82c76a99ba3e870569d0d8b695571",
"codesearch_mirror_revision_timestamp": 1697996685,
"root_solution_revision": "b4877d9c506f5575735ff9b0582a15a7062f9f9e",
"root_solution_revision_timestamp": 1697996393
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931926713332897696"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-mac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "18257"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:38:41.344] Scheduled build:
{
"id": "8766496651467404737",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 2733,
"createdBy": "project:infra",
"createTime": "2023-10-22T22:38:40.842273605Z",
"updateTime": "2023-10-22T22:38:40.842273605Z",
"status": "SCHEDULED",
"input": {
}
}
[22:38:41.344] Task URL: https://cr-buildbucket.appspot.com/build/8766496651467404737
[22:38:41.344] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:2:0) after 3m30s
[22:38:42.243] Received PubSub notification, asking Buildbucket for the build status
[22:38:42.279] Build status: SCHEDULED
[22:40:56.416] Received PubSub notification, asking Buildbucket for the build status
[22:40:56.438] Build status: STARTED
[22:42:11.325] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:2:0)
[22:42:11.350] Build status: STARTED
[22:42:11.350] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:5:0) after 8m28s
[22:50:39.387] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:5:0)
[22:50:39.415] Build status: STARTED
[22:50:39.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:6:0) after 5m1s
[22:55:40.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:6:0)
[22:55:40.426] Build status: STARTED
[22:55:40.427] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:7:0) after 4m0s
[22:59:40.623] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:7:0)
[22:59:40.659] Build status: STARTED
[22:59:40.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:8:0) after 5m38s
[23:05:18.681] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:8:0)
[23:05:18.704] Build status: STARTED
[23:05:18.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:9:0) after 1m13s
[23:06:31.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:9:0)
[23:06:31.827] Build status: STARTED
[23:06:31.827] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:10:0) after 6m30s
[23:13:01.971] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:10:0)
[23:13:02.003] Build status: STARTED
[23:13:02.003] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:11:0) after 2m45s
[23:15:47.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:11:0)
[23:15:47.065] Build status: STARTED
[23:15:47.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:12:0) after 6m44s
[23:22:31.218] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:12:0)
[23:22:31.262] Build status: STARTED
[23:22:31.262] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:13:0) after 3m16s
[23:25:47.280] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:13:0)
[23:25:47.315] Build status: STARTED
[23:25:47.315] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:14:0) after 4m13s
[23:30:00.547] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:14:0)
[23:30:00.685] Build status: STARTED
[23:30:00.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:15:0) after 6m24s
[23:36:24.681] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:15:0)
[23:36:24.714] Build status: STARTED
[23:36:24.714] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:16:0) after 6m4s
[23:42:28.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:16:0)
[23:42:28.750] Build status: STARTED
[23:42:28.750] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:17:0) after 2m13s
[23:44:41.928] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:17:0)
[23:44:42.061] Build status: STARTED
[23:44:42.062] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:18:0) after 6m30s
[23:51:12.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:18:0)
[23:51:12.104] Build status: STARTED
[23:51:12.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:19:0) after 8m28s
[23:59:40.124] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:19:0)
[23:59:40.143] Build status: STARTED
[23:59:40.143] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:20:0) after 9m59s
[00:09:39.239] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:20:0)
[00:09:39.266] Build status: STARTED
[00:09:39.266] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:21:0) after 4m50s
[00:14:29.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:21:0)
[00:14:29.430] Build status: STARTED
[00:14:29.430] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:22:0) after 2m30s
[00:16:59.455] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:22:0)
[00:16:59.478] Build status: STARTED
[00:16:59.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:23:0) after 6m40s
[00:23:39.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:23:0)
[00:23:39.508] Build status: STARTED
[00:23:39.508] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:24:0) after 4m21s
[00:28:00.529] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:24:0)
[00:28:00.559] Build status: STARTED
[00:28:00.559] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:25:0) after 2m26s
[00:30:26.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:25:0)
[00:30:26.886] Build status: STARTED
[00:30:26.886] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:26:0) after 6m31s
[00:36:58.048] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:26:0)
[00:36:58.074] Build status: STARTED
[00:36:58.074] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:27:0) after 1m43s
[00:38:41.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:27:0)
[00:38:41.157] Build status: STARTED
[00:38:41.158] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:28:0) after 1m38s
[00:40:19.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:28:0)
[00:40:19.322] Build status: STARTED
[00:40:19.322] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:29:0) after 2m40s
[00:42:59.442] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:29:0)
[00:42:59.467] Build status: STARTED
[00:42:59.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:30:0) after 3m12s
[00:46:11.491] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:30:0)
[00:46:11.512] Build status: STARTED
[00:46:11.512] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:31:0) after 1m54s
[00:48:05.602] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:31:0)
[00:48:05.702] Build status: STARTED
[00:48:05.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:32:0) after 7m38s
[00:55:43.872] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:32:0)
[00:55:43.891] Build status: STARTED
[00:55:43.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:33:0) after 2m37s
[00:58:20.916] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:33:0)
[00:58:20.934] Build status: STARTED
[00:58:20.934] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:34:0) after 9m24s
[01:07:45.023] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:34:0)
[01:07:45.057] Build status: STARTED
[01:07:45.057] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:35:0) after 6m31s
[01:14:16.087] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:35:0)
[01:14:16.107] Build status: STARTED
[01:14:16.107] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:36:0) after 7m27s
[01:21:43.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:36:0)
[01:21:43.391] Build status: STARTED
[01:21:43.391] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:37:0) after 9m38s
[01:31:21.901] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:37:0)
[01:31:21.933] Build status: STARTED
[01:31:21.933] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:38:0) after 7m24s
[01:38:46.005] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:38:0)
[01:38:46.025] Build status: STARTED
[01:38:46.025] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:39:0) after 8m38s
[01:47:24.090] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:39:0)
[01:47:24.123] Build status: STARTED
[01:47:24.123] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:40:0) after 4m19s
[01:51:43.156] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:40:0)
[01:51:43.183] Build status: STARTED
[01:51:43.183] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:41:0) after 5m19s
[01:57:02.330] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:41:0)
[01:57:02.350] Build status: STARTED
[01:57:02.350] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:42:0) after 6m13s
[02:03:15.526] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:42:0)
[02:03:15.560] Build status: STARTED
[02:03:15.560] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:43:0) after 6m32s
[02:09:47.669] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:43:0)
[02:09:47.726] Build status: STARTED
[02:09:47.726] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:44:0) after 2m28s
[02:12:15.754] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:44:0)
[02:12:15.793] Build status: STARTED
[02:12:15.793] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:45:0) after 6m20s
[02:18:35.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:45:0)
[02:18:35.830] Build status: STARTED
[02:18:35.830] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:46:0) after 8m21s
[02:26:57.334] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:46:0)
[02:26:57.436] Build status: STARTED
[02:26:57.436] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:47:0) after 6m48s
[02:33:45.619] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:47:0)
[02:33:45.653] Build status: STARTED
[02:33:45.653] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:48:0) after 8m41s
[02:42:26.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:48:0)
[02:42:26.743] Build status: STARTED
[02:42:26.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:49:0) after 6m40s
[02:49:06.882] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:49:0)
[02:49:06.984] Build status: STARTED
[02:49:06.984] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:50:0) after 4m31s
[02:53:38.002] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:50:0)
[02:53:38.210] Build status: STARTED
[02:53:38.211] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:51:0) after 1m48s
[02:55:26.321] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:51:0)
[02:55:26.347] Build status: STARTED
[02:55:26.347] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:52:0) after 6m36s
[03:02:02.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:52:0)
[03:02:02.399] Build status: STARTED
[03:02:02.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:53:0) after 6m13s
[03:08:15.506] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:53:0)
[03:08:15.552] Build status: STARTED
[03:08:15.552] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:54:0) after 6m43s
[03:14:58.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:54:0)
[03:14:58.630] Build status: STARTED
[03:14:58.630] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:55:0) after 2m31s
[03:17:29.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:55:0)
[03:17:29.882] Build status: STARTED
[03:17:29.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:56:0) after 6m49s
[03:24:18.900] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:56:0)
[03:24:18.918] Build status: STARTED
[03:24:18.918] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:57:0) after 8m16s
[03:32:34.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:57:0)
[03:32:34.987] Build status: STARTED
[03:32:34.987] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:58:0) after 1m48s
[03:34:23.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:58:0)
[03:34:23.031] Build status: STARTED
[03:34:23.031] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:59:0) after 2m6s
[03:36:29.224] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:59:0)
[03:36:29.254] Build status: STARTED
[03:36:29.254] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8931926713332897696:60:0) after 8m33s
[03:44:58.911] Received PubSub notification, asking Buildbucket for the build status
[03:44:58.931] Build:
{
"id": "8766496651467404737",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 2733,
"createdBy": "project:infra",
"createTime": "2023-10-22T22:38:40.842273605Z",
"startTime": "2023-10-22T22:40:55.898325Z",
"endTime": "2023-10-23T03:44:58.601591620Z",
"updateTime": "2023-10-23T03:44:58.601591620Z",
"status": "SUCCESS",
"input": {
}
}
[03:44:58.931] Invocation finished in 5h6m19.252368306s with status SUCCEEDED