[02:43:50.609] New invocation is queued and will start shortly
[02:43:50.609] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[02:43:51.695] Starting the invocation (attempt 1)
[02:43:51.733] Ignoring gitiles_ref tag without the buildset tag
[02:43:51.733] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:43:51.734] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:43:51.734] Buildbucket request:
{
"requestId": "8962895450330175840",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8962895450330175840",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "addb7782cec77e05c29617541c3275bd57eb3189",
"codesearch_mirror_revision_timestamp": 1668468677,
"root_solution_revision": "0be4a191e274f126412f891f224680c778945219",
"root_solution_revision_timestamp": 1668468019
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:16206",
"user_agent:recipe"
]
},
"id": "f685fac1-0afb-49b3-ad4d-3914692a1f4f",
"title": "codesearch-gen-chromium-initiator/16206"
}
]
},
"codesearch_mirror_revision": "addb7782cec77e05c29617541c3275bd57eb3189",
"codesearch_mirror_revision_timestamp": 1668468677,
"root_solution_revision": "0be4a191e274f126412f891f224680c778945219",
"root_solution_revision_timestamp": 1668468019
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8962895450330175840"
},
{
"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": "16206"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:43:52.171] Scheduled build:
{
"id": "8797465388397683761",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 1074,
"createdBy": "project:infra",
"createTime": "2022-11-15T02:43:51.820711224Z",
"updateTime": "2022-11-15T02:43:51.820711224Z",
"status": "SCHEDULED",
"input": {
}
}
[02:43:52.171] Task URL: https://cr-buildbucket.appspot.com/build/8797465388397683761
[02:43:52.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:2:0) after 4m55s
[02:45:53.957] Received PubSub notification, asking Buildbucket for the build status
[02:45:53.984] Build status: STARTED
[02:48:47.192] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:2:0)
[02:48:47.220] Build status: STARTED
[02:48:47.220] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:4:0) after 7m18s
[02:56:05.346] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:4:0)
[02:56:05.412] Build status: STARTED
[02:56:05.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:5:0) after 5m34s
[03:01:39.442] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:5:0)
[03:01:39.541] Build status: STARTED
[03:01:39.541] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:6:0) after 8m10s
[03:09:49.794] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:6:0)
[03:09:49.820] Build status: STARTED
[03:09:49.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:7:0) after 8m43s
[03:18:32.846] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:7:0)
[03:18:32.877] Build status: STARTED
[03:18:32.877] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:8:0) after 4m24s
[03:22:57.176] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:8:0)
[03:22:57.200] Build status: STARTED
[03:22:57.200] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:9:0) after 5m44s
[03:28:42.027] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:9:0)
[03:28:42.051] Build status: STARTED
[03:28:42.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:10:0) after 1m9s
[03:29:51.071] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:10:0)
[03:29:51.109] Build status: STARTED
[03:29:51.109] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:11:0) after 6m7s
[03:35:58.147] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:11:0)
[03:35:58.177] Build status: STARTED
[03:35:58.177] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:12:0) after 7m41s
[03:43:39.211] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:12:0)
[03:43:39.242] Build status: STARTED
[03:43:39.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:13:0) after 2m53s
[03:46:32.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:13:0)
[03:46:32.574] Build status: STARTED
[03:46:32.575] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:14:0) after 1m51s
[03:48:23.599] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:14:0)
[03:48:23.646] Build status: STARTED
[03:48:23.646] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:15:0) after 9m15s
[03:57:38.665] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:15:0)
[03:57:38.695] Build status: STARTED
[03:57:38.695] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:16:0) after 1m39s
[03:59:17.721] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:16:0)
[03:59:17.754] Build status: STARTED
[03:59:17.754] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:17:0) after 2m49s
[04:02:06.949] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:17:0)
[04:02:06.973] Build status: STARTED
[04:02:06.973] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:18:0) after 5m10s
[04:07:17.524] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:18:0)
[04:07:17.553] Build status: STARTED
[04:07:17.553] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:19:0) after 2m17s
[04:09:34.582] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:19:0)
[04:09:34.606] Build status: STARTED
[04:09:34.606] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:20:0) after 8m17s
[04:17:51.983] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:20:0)
[04:17:52.006] Build status: STARTED
[04:17:52.006] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:21:0) after 2m40s
[04:20:32.032] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:21:0)
[04:20:32.057] Build status: STARTED
[04:20:32.057] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:22:0) after 9m28s
[04:30:00.062] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:22:0)
[04:30:00.089] Build status: STARTED
[04:30:00.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:23:0) after 6m48s
[04:36:48.141] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:23:0)
[04:36:48.171] Build status: STARTED
[04:36:48.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:24:0) after 1m45s
[04:38:33.314] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:24:0)
[04:38:33.359] Build status: STARTED
[04:38:33.359] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:25:0) after 4m37s
[04:43:10.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:25:0)
[04:43:10.543] Build status: STARTED
[04:43:10.543] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:26:0) after 6m5s
[04:49:15.563] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:26:0)
[04:49:15.586] Build status: STARTED
[04:49:15.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:27:0) after 7m33s
[04:56:48.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:27:0)
[04:56:49.046] Build status: STARTED
[04:56:49.047] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:28:0) after 5m58s
[05:02:47.067] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:28:0)
[05:02:47.092] Build status: STARTED
[05:02:47.092] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:29:0) after 1m12s
[05:03:59.232] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:29:0)
[05:03:59.261] Build status: STARTED
[05:03:59.262] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:30:0) after 4m6s
[05:08:05.502] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:30:0)
[05:08:05.555] Build status: STARTED
[05:08:05.555] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:31:0) after 5m47s
[05:13:52.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:31:0)
[05:13:52.567] Build status: STARTED
[05:13:52.567] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:32:0) after 5m27s
[05:19:19.587] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:32:0)
[05:19:19.614] Build status: STARTED
[05:19:19.614] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:33:0) after 8m48s
[05:28:07.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:33:0)
[05:28:07.743] Build status: STARTED
[05:28:07.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:34:0) after 8m59s
[05:37:06.768] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:34:0)
[05:37:06.852] Build status: STARTED
[05:37:06.852] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:35:0) after 2m39s
[05:39:46.271] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:35:0)
[05:39:46.314] Build status: STARTED
[05:39:46.314] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:36:0) after 2m46s
[05:42:32.339] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:36:0)
[05:42:32.414] Build status: STARTED
[05:42:32.414] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:37:0) after 2m13s
[05:44:45.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:37:0)
[05:44:45.556] Build status: STARTED
[05:44:45.556] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:38:0) after 7m5s
[05:51:50.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:38:0)
[05:51:50.717] Build status: STARTED
[05:51:50.717] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:39:0) after 6m1s
[05:57:51.840] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:39:0)
[05:57:51.869] Build status: STARTED
[05:57:51.869] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:40:0) after 2m48s
[06:00:40.411] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:40:0)
[06:00:40.452] Build status: STARTED
[06:00:40.452] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:41:0) after 4m20s
[06:05:00.480] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:41:0)
[06:05:00.509] Build status: STARTED
[06:05:00.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:42:0) after 8m48s
[06:13:48.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:42:0)
[06:13:48.570] Build status: STARTED
[06:13:48.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:43:0) after 1m29s
[06:15:17.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:43:0)
[06:15:17.659] Build status: STARTED
[06:15:17.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:44:0) after 8m16s
[06:23:33.758] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:44:0)
[06:23:33.798] Build status: STARTED
[06:23:33.798] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:45:0) after 7m49s
[06:31:22.823] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:45:0)
[06:31:22.846] Build status: STARTED
[06:31:22.846] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:46:0) after 9m52s
[06:41:14.878] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:46:0)
[06:41:14.902] Build status: STARTED
[06:41:14.902] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:47:0) after 5m37s
[06:46:51.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:47:0)
[06:46:51.951] Build status: STARTED
[06:46:51.951] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:48:0) after 7m9s
[06:54:01.450] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:48:0)
[06:54:01.472] Build status: STARTED
[06:54:01.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:49:0) after 1m48s
[06:55:49.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:49:0)
[06:55:49.738] Build status: STARTED
[06:55:49.738] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:50:0) after 1m9s
[06:56:58.770] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:50:0)
[06:56:58.843] Build status: STARTED
[06:56:58.843] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:51:0) after 8m14s
[07:05:12.876] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:51:0)
[07:05:12.904] Build status: STARTED
[07:05:12.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:52:0) after 2m50s
[07:08:02.932] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:52:0)
[07:08:02.956] Build status: STARTED
[07:08:02.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:53:0) after 1m59s
[07:10:01.981] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:53:0)
[07:10:02.006] Build status: STARTED
[07:10:02.006] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:54:0) after 1m59s
[07:12:01.304] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:54:0)
[07:12:01.335] Build status: STARTED
[07:12:01.335] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:55:0) after 9m12s
[07:21:13.546] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:55:0)
[07:21:13.567] Build status: STARTED
[07:21:13.567] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:56:0) after 5m57s
[07:27:10.599] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:56:0)
[07:27:10.622] Build status: STARTED
[07:27:10.622] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:57:0) after 4m23s
[07:31:33.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:57:0)
[07:31:33.733] Build status: STARTED
[07:31:33.733] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:58:0) after 9m26s
[07:40:59.859] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:58:0)
[07:40:59.881] Build status: STARTED
[07:40:59.881] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8962895450330175840:59:0) after 9m14s
[07:43:15.413] Received PubSub notification, asking Buildbucket for the build status
[07:43:15.457] Build:
{
"id": "8797465388397683761",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 1074,
"createdBy": "project:infra",
"createTime": "2022-11-15T02:43:51.820711224Z",
"startTime": "2022-11-15T02:45:52.914727Z",
"endTime": "2022-11-15T07:43:14.813186492Z",
"updateTime": "2022-11-15T07:43:14.813186492Z",
"status": "SUCCESS",
"input": {
}
}
[07:43:15.457] Invocation finished in 4h59m24.863511835s with status SUCCEEDED