[05:01:06.910] New invocation is queued and will start shortly
[05:01:08.117] Starting the invocation (attempt 1)
[05:01:08.141] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67d95fa40f452147e36a36594a4d2d4367518865"
[05:01:08.141] Popped gitiles commit info from properties and tags
[05:01:08.142] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:01:08.142] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:01:08.142] Buildbucket request:
{
"requestId": "8869300147651286848",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67d95fa40f452147e36a36594a4d2d4367518865",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869300147651286848"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Linux ASan Debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:01:08.737] Scheduled build:
{
"id": "8703870085617423713",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 180800,
"createdBy": "project:chromium",
"createTime": "2025-09-13T05:01:08.217124062Z",
"updateTime": "2025-09-13T05:01:08.217124062Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67d95fa40f452147e36a36594a4d2d4367518865",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:01:08.737] Task URL: https://cr-buildbucket.appspot.com/build/8703870085617423713
[05:01:08.737] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:2:0) after 5m56s
[05:01:09.665] Received PubSub notification, asking Buildbucket for the build status
[05:01:09.718] Build status: SCHEDULED
[05:07:04.800] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:2:0)
[05:07:04.818] Build status: SCHEDULED
[05:07:04.818] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:4:0) after 9m26s
[05:16:30.881] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:4:0)
[05:16:31.027] Build status: SCHEDULED
[05:16:31.027] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:5:0) after 3m8s
[05:19:39.050] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:5:0)
[05:19:39.128] Build status: SCHEDULED
[05:19:39.128] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:6:0) after 7m38s
[05:24:10.911] Received PubSub notification, asking Buildbucket for the build status
[05:24:10.927] Build status: STARTED
[05:27:17.161] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:6:0)
[05:27:17.181] Build status: STARTED
[05:27:17.181] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:8:0) after 2m49s
[05:30:06.285] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:8:0)
[05:30:06.312] Build status: STARTED
[05:30:06.312] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:9:0) after 4m52s
[05:34:58.428] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:9:0)
[05:34:58.447] Build status: STARTED
[05:34:58.447] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:10:0) after 9m14s
[05:44:12.502] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:10:0)
[05:44:12.531] Build status: STARTED
[05:44:12.531] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:11:0) after 5m10s
[05:49:22.546] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:11:0)
[05:49:22.567] Build status: STARTED
[05:49:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:12:0) after 8m48s
[05:58:10.708] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:12:0)
[05:58:10.736] Build status: STARTED
[05:58:10.736] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:13:0) after 1m33s
[05:59:43.747] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:13:0)
[05:59:43.765] Build status: STARTED
[05:59:43.765] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:14:0) after 3m1s
[06:02:44.901] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:14:0)
[06:02:44.926] Build status: STARTED
[06:02:44.926] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:15:0) after 3m36s
[06:06:21.186] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:15:0)
[06:06:21.215] Build status: STARTED
[06:06:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:16:0) after 9m20s
[06:15:41.230] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:16:0)
[06:15:41.242] Build status: STARTED
[06:15:41.242] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:17:0) after 1m30s
[06:17:11.457] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:17:0)
[06:17:11.473] Build status: STARTED
[06:17:11.473] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:18:0) after 7m10s
[06:24:21.488] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:18:0)
[06:24:21.519] Build status: STARTED
[06:24:21.519] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:19:0) after 1m7s
[06:25:28.532] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:19:0)
[06:25:28.555] Build status: STARTED
[06:25:28.555] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:20:0) after 2m33s
[06:28:01.569] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:20:0)
[06:28:01.588] Build status: STARTED
[06:28:01.588] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:21:0) after 3m8s
[06:31:09.663] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:21:0)
[06:31:09.708] Build status: STARTED
[06:31:09.708] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:22:0) after 2m57s
[06:34:06.878] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:22:0)
[06:34:06.977] Build status: STARTED
[06:34:06.977] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:23:0) after 5m51s
[06:39:58.051] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:23:0)
[06:39:58.115] Build status: STARTED
[06:39:58.115] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:24:0) after 6m21s
[06:46:19.704] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:24:0)
[06:46:19.754] Build status: STARTED
[06:46:19.754] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:25:0) after 3m36s
[06:49:55.876] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:25:0)
[06:49:55.894] Build status: STARTED
[06:49:55.894] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:26:0) after 7m6s
[06:57:02.067] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:26:0)
[06:57:02.134] Build status: STARTED
[06:57:02.135] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:27:0) after 8m34s
[07:05:36.407] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:27:0)
[07:05:36.425] Build status: STARTED
[07:05:36.425] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:28:0) after 4m6s
[07:09:42.548] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:28:0)
[07:09:42.565] Build status: STARTED
[07:09:42.565] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:29:0) after 6m40s
[07:16:22.723] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:29:0)
[07:16:22.773] Build status: STARTED
[07:16:22.773] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:30:0) after 4m46s
[07:21:08.790] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:30:0)
[07:21:08.808] Build status: STARTED
[07:21:08.808] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:31:0) after 1m57s
[07:23:05.814] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:31:0)
[07:23:05.831] Build status: STARTED
[07:23:05.831] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:32:0) after 1m27s
[07:24:32.848] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:32:0)
[07:24:32.893] Build status: STARTED
[07:24:32.893] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:33:0) after 9m26s
[07:33:59.086] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:33:0)
[07:33:59.748] Build status: STARTED
[07:33:59.748] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:34:0) after 4m47s
[07:38:46.910] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:34:0)
[07:38:46.929] Build status: STARTED
[07:38:46.929] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:35:0) after 4m28s
[07:43:14.946] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:35:0)
[07:43:14.966] Build status: STARTED
[07:43:14.966] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:36:0) after 7m55s
[07:51:09.979] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:36:0)
[07:51:09.996] Build status: STARTED
[07:51:09.996] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:37:0) after 7m40s
[07:58:50.015] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:37:0)
[07:58:50.039] Build status: STARTED
[07:58:50.039] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8869300147651286848:38:0) after 8m23s
[07:59:20.923] Received PubSub notification, asking Buildbucket for the build status
[07:59:20.938] Build:
{
"id": "8703870085617423713",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 180800,
"createdBy": "project:chromium",
"createTime": "2025-09-13T05:01:08.217124062Z",
"startTime": "2025-09-13T05:24:06.603605819Z",
"endTime": "2025-09-13T07:59:20.548013270Z",
"updateTime": "2025-09-13T07:59:20.548013270Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67d95fa40f452147e36a36594a4d2d4367518865",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:59:20.938] Invocation finished in 2h58m14.044057017s with status SUCCEEDED