[04:22:27.426] New invocation is queued and will start shortly
[04:22:27.426] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:22:28.563] Starting the invocation (attempt 1)
[04:22:28.611] Ignoring gitiles_ref tag without the buildset tag
[04:22:28.611] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:22:28.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:22:28.611] Buildbucket request:
{
"requestId": "8967147303522232560",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8967147303522232560",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "f6b76bd1ce1243553781de258c0ed19e66b70ee3",
"codesearch_mirror_revision_timestamp": 1664409444,
"root_solution_revision": "e79f1038031a937d2309d0a2fcc59281b3bd979e",
"root_solution_revision_timestamp": 1664408739
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15924",
"user_agent:recipe"
]
},
"id": "ab09d893-3550-4b69-acce-61adb9776e58",
"title": "codesearch-gen-chromium-initiator/15924"
},
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "35ba7fc452af44cd1281e7c2fabf40cf8d3f00a3",
"codesearch_mirror_revision_timestamp": 1664423965,
"root_solution_revision": "d8768567153906ad05e122632693202d898ec5c6",
"root_solution_revision_timestamp": 1664423806
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15925",
"user_agent:recipe"
]
},
"id": "ea7fa5a0-3c0d-41bb-976c-c944f1620013",
"title": "codesearch-gen-chromium-initiator/15925"
}
]
},
"codesearch_mirror_revision": "35ba7fc452af44cd1281e7c2fabf40cf8d3f00a3",
"codesearch_mirror_revision_timestamp": 1664423965,
"root_solution_revision": "d8768567153906ad05e122632693202d898ec5c6",
"root_solution_revision_timestamp": 1664423806
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967147303522232560"
},
{
"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": "15925"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:22:29.129] Scheduled build:
{
"id": "8801717241406524753",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 840,
"createdBy": "project:infra",
"createTime": "2022-09-29T04:22:28.808661469Z",
"updateTime": "2022-09-29T04:22:28.808661469Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[04:22:29.129] Task URL: https://cr-buildbucket.appspot.com/build/8801717241406524753
[04:22:29.129] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:2:0) after 4m50s
[04:24:36.779] Received PubSub notification, asking Buildbucket for the build status
[04:24:36.816] Build status: STARTED
[04:27:19.155] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:2:0)
[04:27:19.404] Build status: STARTED
[04:27:19.404] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:4:0) after 2m25s
[04:29:44.983] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:4:0)
[04:29:45.007] Build status: STARTED
[04:29:45.007] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:5:0) after 4m51s
[04:34:36.158] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:5:0)
[04:34:36.184] Build status: STARTED
[04:34:36.184] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:6:0) after 4m56s
[04:39:32.204] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:6:0)
[04:39:32.240] Build status: STARTED
[04:39:32.240] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:7:0) after 5m50s
[04:45:22.309] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:7:0)
[04:45:22.331] Build status: STARTED
[04:45:22.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:8:0) after 6m24s
[04:51:46.432] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:8:0)
[04:51:46.504] Build status: STARTED
[04:51:46.504] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:9:0) after 9m10s
[05:00:56.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:9:0)
[05:00:56.568] Build status: STARTED
[05:00:56.568] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:10:0) after 9m11s
[05:10:07.643] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:10:0)
[05:10:07.697] Build status: STARTED
[05:10:07.697] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:11:0) after 9m3s
[05:19:10.870] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:11:0)
[05:19:11.004] Build status: STARTED
[05:19:11.004] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:12:0) after 6m37s
[05:25:48.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:12:0)
[05:25:48.078] Build status: STARTED
[05:25:48.078] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:13:0) after 5m58s
[05:31:46.106] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:13:0)
[05:31:46.134] Build status: STARTED
[05:31:46.134] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:14:0) after 3m46s
[05:35:32.155] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:14:0)
[05:35:32.195] Build status: STARTED
[05:35:32.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:15:0) after 3m6s
[05:38:38.218] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:15:0)
[05:38:38.248] Build status: STARTED
[05:38:38.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:16:0) after 1m12s
[05:39:50.556] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:16:0)
[05:39:50.590] Build status: STARTED
[05:39:50.590] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:17:0) after 2m52s
[05:42:42.614] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:17:0)
[05:42:42.640] Build status: STARTED
[05:42:42.640] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:18:0) after 6m20s
[05:49:02.775] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:18:0)
[05:49:02.812] Build status: STARTED
[05:49:02.812] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:19:0) after 9m58s
[05:59:00.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:19:0)
[05:59:00.924] Build status: STARTED
[05:59:00.924] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:20:0) after 9m9s
[06:08:09.956] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:20:0)
[06:08:09.979] Build status: STARTED
[06:08:09.979] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:21:0) after 3m35s
[06:11:45.033] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:21:0)
[06:11:45.063] Build status: STARTED
[06:11:45.063] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:22:0) after 3m52s
[06:15:37.213] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:22:0)
[06:15:37.253] Build status: STARTED
[06:15:37.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:23:0) after 9m35s
[06:25:12.297] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:23:0)
[06:25:12.427] Build status: STARTED
[06:25:12.427] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:24:0) after 9m48s
[06:35:00.596] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:24:0)
[06:35:00.625] Build status: STARTED
[06:35:00.625] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:25:0) after 6m8s
[06:41:08.698] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:25:0)
[06:41:08.731] Build status: STARTED
[06:41:08.731] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:26:0) after 9m36s
[06:50:44.751] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:26:0)
[06:50:44.775] Build status: STARTED
[06:50:44.775] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:27:0) after 8m43s
[06:59:27.989] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:27:0)
[06:59:28.033] Build status: STARTED
[06:59:28.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:28:0) after 6m27s
[07:05:55.095] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:28:0)
[07:05:55.145] Build status: STARTED
[07:05:55.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:29:0) after 2m28s
[07:08:23.551] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:29:0)
[07:08:23.600] Build status: STARTED
[07:08:23.600] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:30:0) after 6m7s
[07:14:30.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:30:0)
[07:14:30.646] Build status: STARTED
[07:14:30.646] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:31:0) after 1m43s
[07:16:13.666] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:31:0)
[07:16:13.692] Build status: STARTED
[07:16:13.692] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:32:0) after 8m17s
[07:24:30.691] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:32:0)
[07:24:30.732] Build status: STARTED
[07:24:30.732] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:33:0) after 3m47s
[07:28:17.996] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:33:0)
[07:28:18.017] Build status: STARTED
[07:28:18.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:34:0) after 3m2s
[07:31:20.123] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:34:0)
[07:31:20.211] Build status: STARTED
[07:31:20.211] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:35:0) after 8m28s
[07:39:48.265] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:35:0)
[07:39:48.304] Build status: STARTED
[07:39:48.304] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:36:0) after 4m26s
[07:44:14.418] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:36:0)
[07:44:14.467] Build status: STARTED
[07:44:14.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:37:0) after 2m30s
[07:46:44.645] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:37:0)
[07:46:44.694] Build status: STARTED
[07:46:44.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:38:0) after 3m48s
[07:50:32.720] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:38:0)
[07:50:32.745] Build status: STARTED
[07:50:32.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:39:0) after 7m44s
[07:58:16.870] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:39:0)
[07:58:16.893] Build status: STARTED
[07:58:16.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:40:0) after 6m0s
[08:04:16.939] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:40:0)
[08:04:17.022] Build status: STARTED
[08:04:17.022] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:41:0) after 5m5s
[08:09:22.043] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:41:0)
[08:09:22.068] Build status: STARTED
[08:09:22.068] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:42:0) after 9m25s
[08:18:47.156] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:42:0)
[08:18:47.198] Build status: STARTED
[08:18:47.198] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:43:0) after 6m26s
[08:25:13.227] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:43:0)
[08:25:13.265] Build status: STARTED
[08:25:13.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:44:0) after 5m56s
[08:31:09.262] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:44:0)
[08:31:09.308] Build status: STARTED
[08:31:09.308] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:45:0) after 1m26s
[08:32:35.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:45:0)
[08:32:35.376] Build status: STARTED
[08:32:35.376] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:46:0) after 2m51s
[08:35:26.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:46:0)
[08:35:26.443] Build status: STARTED
[08:35:26.443] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:47:0) after 8m25s
[08:43:51.642] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:47:0)
[08:43:51.675] Build status: STARTED
[08:43:51.675] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:48:0) after 2m1s
[08:45:52.703] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:48:0)
[08:45:52.745] Build status: STARTED
[08:45:52.745] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:49:0) after 7m16s
[08:53:08.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:49:0)
[08:53:08.946] Build status: STARTED
[08:53:08.946] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:50:0) after 3m27s
[08:56:35.970] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:50:0)
[08:56:35.997] Build status: STARTED
[08:56:35.997] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:51:0) after 7m23s
[09:03:59.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:51:0)
[09:03:59.147] Build status: STARTED
[09:03:59.147] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:52:0) after 7m41s
[09:11:40.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:52:0)
[09:11:40.212] Build status: STARTED
[09:11:40.212] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:53:0) after 4m57s
[09:16:37.249] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:53:0)
[09:16:37.336] Build status: STARTED
[09:16:37.336] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:54:0) after 8m41s
[09:25:18.410] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:54:0)
[09:25:18.449] Build status: STARTED
[09:25:18.449] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:55:0) after 9m19s
[09:34:37.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:55:0)
[09:34:37.498] Build status: STARTED
[09:34:37.498] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:56:0) after 4m3s
[09:38:40.534] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:56:0)
[09:38:40.630] Build status: STARTED
[09:38:40.630] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:57:0) after 4m26s
[09:43:06.684] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:57:0)
[09:43:06.721] Build status: STARTED
[09:43:06.721] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:58:0) after 4m13s
[09:47:20.031] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:58:0)
[09:47:20.078] Build status: STARTED
[09:47:20.079] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8967147303522232560:59:0) after 8m23s
[09:54:28.926] Received PubSub notification, asking Buildbucket for the build status
[09:54:28.967] Build:
{
"id": "8801717241406524753",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 840,
"createdBy": "project:infra",
"createTime": "2022-09-29T04:22:28.808661469Z",
"startTime": "2022-09-29T04:24:35.866330Z",
"endTime": "2022-09-29T09:54:28.572038145Z",
"updateTime": "2022-09-29T09:54:28.572038145Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[09:54:28.967] Invocation finished in 5h32m1.560495209s with status SUCCEEDED