[12:10:44.150] New invocation is queued and will start shortly
[12:10:45.284] Starting the invocation (attempt 1)
[12:10:45.315] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65a41485b2d5be054470852ea53ae94bc63213c2"
[12:10:45.315] Popped gitiles commit info from properties and tags
[12:10:45.315] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:10:45.315] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:10:45.316] Buildbucket request:
{
"requestId": "8878604605794652832",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8878604605794652832",
"job": "chromium-m138/Libfuzzer Upload Linux ASan",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "62aa6f4f2e76d3d3900818ad959bb7c6791f7bde"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@62aa6f4f2e76d3d3900818ad959bb7c6791f7bde",
"title": "62aa6f4f2e76d3d3900818ad959bb7c6791f7bde",
"url": "https://chromium.googlesource.com/chromium/src/+/62aa6f4f2e76d3d3900818ad959bb7c6791f7bde"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92c117f979a6b21ca093a2d2567bfafd5c77f0fa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@92c117f979a6b21ca093a2d2567bfafd5c77f0fa",
"title": "92c117f979a6b21ca093a2d2567bfafd5c77f0fa",
"url": "https://chromium.googlesource.com/chromium/src/+/92c117f979a6b21ca093a2d2567bfafd5c77f0fa"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1f3f473d8a67bbb3d3ea51784cd2c7c49e2126ed"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@1f3f473d8a67bbb3d3ea51784cd2c7c49e2126ed",
"title": "1f3f473d8a67bbb3d3ea51784cd2c7c49e2126ed",
"url": "https://chromium.googlesource.com/chromium/src/+/1f3f473d8a67bbb3d3ea51784cd2c7c49e2126ed"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a50c5ac50ecbe58075da12a0641e62d013d7f8ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@a50c5ac50ecbe58075da12a0641e62d013d7f8ef",
"title": "a50c5ac50ecbe58075da12a0641e62d013d7f8ef",
"url": "https://chromium.googlesource.com/chromium/src/+/a50c5ac50ecbe58075da12a0641e62d013d7f8ef"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6904cda22ae3dce69d70559271587dc880a1b01d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@6904cda22ae3dce69d70559271587dc880a1b01d",
"title": "6904cda22ae3dce69d70559271587dc880a1b01d",
"url": "https://chromium.googlesource.com/chromium/src/+/6904cda22ae3dce69d70559271587dc880a1b01d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7c310a5550dc208a2c3955e6c19c9a00b4faa7e4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@7c310a5550dc208a2c3955e6c19c9a00b4faa7e4",
"title": "7c310a5550dc208a2c3955e6c19c9a00b4faa7e4",
"url": "https://chromium.googlesource.com/chromium/src/+/7c310a5550dc208a2c3955e6c19c9a00b4faa7e4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3e4c8fa71ab807d0d8dce3860130aae19dc3dece"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@3e4c8fa71ab807d0d8dce3860130aae19dc3dece",
"title": "3e4c8fa71ab807d0d8dce3860130aae19dc3dece",
"url": "https://chromium.googlesource.com/chromium/src/+/3e4c8fa71ab807d0d8dce3860130aae19dc3dece"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "65a41485b2d5be054470852ea53ae94bc63213c2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@65a41485b2d5be054470852ea53ae94bc63213c2",
"title": "65a41485b2d5be054470852ea53ae94bc63213c2",
"url": "https://chromium.googlesource.com/chromium/src/+/65a41485b2d5be054470852ea53ae94bc63213c2"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "65a41485b2d5be054470852ea53ae94bc63213c2",
"ref": "refs/branch-heads/7204"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878604605794652832"
},
{
"key": "scheduler_job_id",
"value": "chromium-m138/Libfuzzer Upload Linux ASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:10:45.867] Scheduled build:
{
"id": "8713174543827527745",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan"
},
"number": 51,
"createdBy": "project:chromium-m138",
"createTime": "2025-06-02T12:10:45.394873661Z",
"updateTime": "2025-06-02T12:10:45.394873661Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "65a41485b2d5be054470852ea53ae94bc63213c2",
"ref": "refs/branch-heads/7204"
}
}
}
[12:10:45.867] Task URL: https://cr-buildbucket.appspot.com/build/8713174543827527745
[12:10:45.867] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:2:0) after 4m11s
[12:10:46.854] Received PubSub notification, asking Buildbucket for the build status
[12:10:46.879] Build status: SCHEDULED
[12:10:53.918] Received PubSub notification, asking Buildbucket for the build status
[12:10:53.945] Build status: STARTED
[12:14:56.994] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:2:0)
[12:14:57.023] Build status: STARTED
[12:14:57.023] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:5:0) after 9m54s
[12:24:51.056] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:5:0)
[12:24:51.080] Build status: STARTED
[12:24:51.080] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:6:0) after 5m8s
[12:29:59.231] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:6:0)
[12:29:59.253] Build status: STARTED
[12:29:59.254] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:7:0) after 9m11s
[12:39:10.279] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:7:0)
[12:39:10.341] Build status: STARTED
[12:39:10.341] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:8:0) after 1m35s
[12:40:45.955] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:8:0)
[12:40:46.007] Build status: STARTED
[12:40:46.007] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:9:0) after 5m21s
[12:46:07.414] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:9:0)
[12:46:07.436] Build status: STARTED
[12:46:07.436] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:10:0) after 9m54s
[12:56:01.603] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:10:0)
[12:56:01.629] Build status: STARTED
[12:56:01.629] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:11:0) after 2m11s
[12:58:12.650] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:11:0)
[12:58:12.717] Build status: STARTED
[12:58:12.717] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:12:0) after 3m14s
[13:01:26.739] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:12:0)
[13:01:26.760] Build status: STARTED
[13:01:26.760] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:13:0) after 7m23s
[13:08:49.837] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:13:0)
[13:08:49.921] Build status: STARTED
[13:08:49.921] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:14:0) after 3m30s
[13:12:19.958] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:14:0)
[13:12:19.989] Build status: STARTED
[13:12:19.989] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:15:0) after 3m0s
[13:15:19.961] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:15:0)
[13:15:19.981] Build status: STARTED
[13:15:19.981] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:16:0) after 2m3s
[13:17:22.998] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:16:0)
[13:17:23.017] Build status: STARTED
[13:17:23.017] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:17:0) after 4m7s
[13:21:30.270] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:17:0)
[13:21:30.289] Build status: STARTED
[13:21:30.289] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:18:0) after 4m50s
[13:26:21.089] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:18:0)
[13:26:21.110] Build status: STARTED
[13:26:21.110] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:19:0) after 6m40s
[13:33:01.154] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:19:0)
[13:33:01.234] Build status: STARTED
[13:33:01.234] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:20:0) after 4m49s
[13:37:50.275] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:20:0)
[13:37:50.292] Build status: STARTED
[13:37:50.292] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:21:0) after 2m39s
[13:40:30.049] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:21:0)
[13:40:30.067] Build status: STARTED
[13:40:30.067] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:22:0) after 7m35s
[13:48:05.089] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:22:0)
[13:48:05.130] Build status: STARTED
[13:48:05.131] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:23:0) after 4m18s
[13:52:23.233] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:23:0)
[13:52:23.254] Build status: STARTED
[13:52:23.254] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:24:0) after 4m15s
[13:56:39.000] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:24:0)
[13:56:39.022] Build status: STARTED
[13:56:39.022] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:25:0) after 3m45s
[14:00:24.051] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:25:0)
[14:00:24.131] Build status: STARTED
[14:00:24.131] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:26:0) after 2m43s
[14:03:07.180] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:26:0)
[14:03:07.219] Build status: STARTED
[14:03:07.219] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:27:0) after 6m15s
[14:09:22.267] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:27:0)
[14:09:22.343] Build status: STARTED
[14:09:22.343] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:28:0) after 5m1s
[14:14:23.411] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:28:0)
[14:14:23.493] Build status: STARTED
[14:14:23.493] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:29:0) after 8m37s
[14:23:00.525] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:29:0)
[14:23:00.562] Build status: STARTED
[14:23:00.562] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:30:0) after 5m54s
[14:28:54.627] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:30:0)
[14:28:54.647] Build status: STARTED
[14:28:54.647] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:31:0) after 3m58s
[14:32:52.907] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:31:0)
[14:32:53.069] Build status: STARTED
[14:32:53.069] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:32:0) after 8m9s
[14:41:02.104] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:32:0)
[14:41:02.129] Build status: STARTED
[14:41:02.129] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:33:0) after 5m2s
[14:46:04.194] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:33:0)
[14:46:04.240] Build status: STARTED
[14:46:04.240] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:34:0) after 5m26s
[14:51:30.262] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:34:0)
[14:51:30.279] Build status: STARTED
[14:51:30.279] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:35:0) after 3m48s
[14:55:18.356] Handling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:35:0)
[14:55:18.383] Build status: STARTED
[14:55:18.383] Scheduling timer "check-buildbucket-build-status" (chromium-m138/Libfuzzer Upload Linux ASan:8878604605794652832:36:0) after 6m43s
[14:55:21.346] Received PubSub notification, asking Buildbucket for the build status
[14:55:21.425] Build:
{
"id": "8713174543827527745",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan"
},
"number": 51,
"createdBy": "project:chromium-m138",
"createTime": "2025-06-02T12:10:45.394873661Z",
"startTime": "2025-06-02T12:10:52.413298621Z",
"endTime": "2025-06-02T14:55:20.445875325Z",
"updateTime": "2025-06-02T14:55:20.445875325Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "65a41485b2d5be054470852ea53ae94bc63213c2",
"ref": "refs/branch-heads/7204"
}
}
}
[14:55:21.425] Invocation finished in 2h44m37.290057948s with status SUCCEEDED