[12:03:01.021] New invocation is queued and will start shortly
[12:03:01.021] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:03:02.114] Starting the invocation (attempt 1)
[12:03:02.141] Ignoring gitiles_ref tag without the buildset tag
[12:03:02.141] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:03:02.141] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:03:02.142] Buildbucket request:
{
"requestId": "8924265962486616928",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8924265962486616928",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "5482ddd4950acd1c347abc5e088b1d31aaa184ae",
"codesearch_mirror_revision_timestamp": 1705314197,
"root_solution_revision": "100e18015abff2341b319bf40968bbd7d779fd22",
"root_solution_revision_timestamp": 1705314095
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:18765",
"user_agent:recipe"
]
},
"id": "de8ba692-45ca-433f-adbd-f8ba5b26e86b",
"title": "codesearch-gen-chromium-initiator/18765"
}
]
},
"codesearch_mirror_revision": "5482ddd4950acd1c347abc5e088b1d31aaa184ae",
"codesearch_mirror_revision_timestamp": 1705314197,
"root_solution_revision": "100e18015abff2341b319bf40968bbd7d779fd22",
"root_solution_revision_timestamp": 1705314095
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924265962486616928"
},
{
"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": "18765"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:03:02.914] Scheduled build:
{
"id": "8758835900575367633",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 3237,
"createdBy": "project:infra",
"createTime": "2024-01-15T12:03:02.212435732Z",
"updateTime": "2024-01-15T12:03:02.212435732Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[12:03:02.914] Task URL: https://cr-buildbucket.appspot.com/build/8758835900575367633
[12:03:02.914] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:2:0) after 8m4s
[12:03:04.080] Received PubSub notification, asking Buildbucket for the build status
[12:03:04.238] Build status: SCHEDULED
[12:03:17.731] Received PubSub notification, asking Buildbucket for the build status
[12:03:17.759] Build status: STARTED
[12:11:07.133] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:2:0)
[12:11:07.162] Build status: STARTED
[12:11:07.162] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:5:0) after 3m15s
[12:14:22.193] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:5:0)
[12:14:22.244] Build status: STARTED
[12:14:22.244] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:6:0) after 4m54s
[12:19:16.438] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:6:0)
[12:19:16.463] Build status: STARTED
[12:19:16.463] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:7:0) after 4m19s
[12:23:35.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:7:0)
[12:23:35.728] Build status: STARTED
[12:23:35.728] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:8:0) after 3m10s
[12:26:45.913] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:8:0)
[12:26:45.931] Build status: STARTED
[12:26:45.931] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:9:0) after 9m8s
[12:35:54.104] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:9:0)
[12:35:54.122] Build status: STARTED
[12:35:54.122] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:10:0) after 3m53s
[12:39:47.201] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:10:0)
[12:39:47.229] Build status: STARTED
[12:39:47.229] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:11:0) after 1m58s
[12:41:45.252] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:11:0)
[12:41:45.268] Build status: STARTED
[12:41:45.268] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:12:0) after 4m22s
[12:46:07.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:12:0)
[12:46:07.673] Build status: STARTED
[12:46:07.673] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:13:0) after 1m5s
[12:47:12.805] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:13:0)
[12:47:12.859] Build status: STARTED
[12:47:12.859] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:14:0) after 8m13s
[12:55:25.996] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:14:0)
[12:55:26.075] Build status: STARTED
[12:55:26.075] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:15:0) after 3m24s
[12:58:50.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:15:0)
[12:58:50.216] Build status: STARTED
[12:58:50.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:16:0) after 3m21s
[13:02:11.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:16:0)
[13:02:11.269] Build status: STARTED
[13:02:11.269] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:17:0) after 8m18s
[13:10:29.526] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:17:0)
[13:10:29.548] Build status: STARTED
[13:10:29.548] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:18:0) after 4m20s
[13:14:49.694] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:18:0)
[13:14:49.720] Build status: STARTED
[13:14:49.720] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:19:0) after 2m45s
[13:17:34.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:19:0)
[13:17:34.805] Build status: STARTED
[13:17:34.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:20:0) after 1m13s
[13:18:47.844] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:20:0)
[13:18:47.875] Build status: STARTED
[13:18:47.875] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:21:0) after 8m43s
[13:27:30.884] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:21:0)
[13:27:30.967] Build status: STARTED
[13:27:30.967] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:22:0) after 3m46s
[13:31:17.132] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:22:0)
[13:31:17.152] Build status: STARTED
[13:31:17.152] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:23:0) after 1m34s
[13:32:51.636] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:23:0)
[13:32:51.657] Build status: STARTED
[13:32:51.657] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:24:0) after 3m32s
[13:36:23.685] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:24:0)
[13:36:23.718] Build status: STARTED
[13:36:23.718] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:25:0) after 3m47s
[13:40:10.767] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:25:0)
[13:40:10.802] Build status: STARTED
[13:40:10.802] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:26:0) after 1m15s
[13:41:25.825] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:26:0)
[13:41:25.997] Build status: STARTED
[13:41:25.997] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8924265962486616928:27:0) after 4m38s
[13:44:09.500] Received PubSub notification, asking Buildbucket for the build status
[13:44:09.522] Build:
{
"id": "8758835900575367633",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 3237,
"createdBy": "project:infra",
"createTime": "2024-01-15T12:03:02.212435732Z",
"startTime": "2024-01-15T12:03:10.568017Z",
"endTime": "2024-01-15T13:44:08.761692Z",
"updateTime": "2024-01-15T13:44:08.761692Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[13:44:09.522] Invocation finished in 1h41m8.515761746s with status SUCCEEDED