[07:54:58.617] New invocation is queued and will start shortly
[07:54:59.771] Starting the invocation (attempt 1)
[07:54:59.801] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ea5374a96a0dd6f2433c35b2072230d50e8319ba"
[07:54:59.801] Popped gitiles commit info from properties and tags
[07:54:59.801] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:54:59.802] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:54:59.802] Buildbucket request:
{
"requestId": "8915856049932505104",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxASanLibfuzzer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ea5374a96a0dd6f2433c35b2072230d50e8319ba",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915856049932505104"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTLinuxASanLibfuzzer"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:55:00.443] Scheduled build:
{
"id": "8750425987954229809",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxASanLibfuzzer"
},
"number": 25976,
"createdBy": "project:chromium",
"createTime": "2024-04-17T07:54:59.882726538Z",
"updateTime": "2024-04-17T07:54:59.882726538Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ea5374a96a0dd6f2433c35b2072230d50e8319ba",
"ref": "refs/heads/main"
}
}
}
[07:55:00.443] Task URL: https://cr-buildbucket.appspot.com/build/8750425987954229809
[07:55:00.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:2:0) after 7m38s
[07:55:01.445] Received PubSub notification, asking Buildbucket for the build status
[07:55:01.478] Build status: SCHEDULED
[07:56:10.230] Received PubSub notification, asking Buildbucket for the build status
[07:56:10.252] Build status: STARTED
[08:02:38.466] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:2:0)
[08:02:38.493] Build status: STARTED
[08:02:38.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:5:0) after 5m0s
[08:07:38.617] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:5:0)
[08:07:38.657] Build status: STARTED
[08:07:38.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:6:0) after 8m33s
[08:16:11.954] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:6:0)
[08:16:11.975] Build status: STARTED
[08:16:11.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:7:0) after 5m43s
[08:21:55.047] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:7:0)
[08:21:55.225] Build status: STARTED
[08:21:55.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:8:0) after 5m41s
[08:27:36.245] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:8:0)
[08:27:36.272] Build status: STARTED
[08:27:36.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:9:0) after 6m33s
[08:34:09.321] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:9:0)
[08:34:09.352] Build status: STARTED
[08:34:09.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:10:0) after 7m3s
[08:41:12.530] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:10:0)
[08:41:12.603] Build status: STARTED
[08:41:12.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:11:0) after 1m25s
[08:42:37.676] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:11:0)
[08:42:37.693] Build status: STARTED
[08:42:37.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:12:0) after 3m3s
[08:45:40.954] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:12:0)
[08:45:40.973] Build status: STARTED
[08:45:40.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:13:0) after 8m24s
[08:54:04.981] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:13:0)
[08:54:05.001] Build status: STARTED
[08:54:05.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:14:0) after 1m19s
[08:55:24.078] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:14:0)
[08:55:24.117] Build status: STARTED
[08:55:24.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:15:0) after 9m13s
[09:04:37.180] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:15:0)
[09:04:37.206] Build status: STARTED
[09:04:37.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:16:0) after 9m46s
[09:14:23.592] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:16:0)
[09:14:23.610] Build status: STARTED
[09:14:23.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:17:0) after 8m6s
[09:22:29.843] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:17:0)
[09:22:29.881] Build status: STARTED
[09:22:29.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:18:0) after 9m1s
[09:31:30.938] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:18:0)
[09:31:31.009] Build status: STARTED
[09:31:31.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:19:0) after 1m59s
[09:33:30.131] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:19:0)
[09:33:30.156] Build status: STARTED
[09:33:30.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:20:0) after 5m4s
[09:38:34.175] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:20:0)
[09:38:34.248] Build status: STARTED
[09:38:34.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:21:0) after 9m42s
[09:48:16.329] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:21:0)
[09:48:16.353] Build status: STARTED
[09:48:16.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:22:0) after 9m3s
[09:57:19.446] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:22:0)
[09:57:19.473] Build status: STARTED
[09:57:19.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:23:0) after 3m10s
[10:00:29.913] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:23:0)
[10:00:29.934] Build status: STARTED
[10:00:29.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:24:0) after 4m13s
[10:04:43.087] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:24:0)
[10:04:43.117] Build status: STARTED
[10:04:43.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:25:0) after 6m9s
[10:10:52.384] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:25:0)
[10:10:52.446] Build status: STARTED
[10:10:52.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:26:0) after 5m26s
[10:16:18.479] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:26:0)
[10:16:18.529] Build status: STARTED
[10:16:18.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:27:0) after 9m39s
[10:25:57.649] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:27:0)
[10:25:57.679] Build status: STARTED
[10:25:57.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:28:0) after 5m13s
[10:31:10.719] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:28:0)
[10:31:10.744] Build status: STARTED
[10:31:10.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:29:0) after 1m43s
[10:32:54.013] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:29:0)
[10:32:54.035] Build status: STARTED
[10:32:54.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:30:0) after 5m22s
[10:38:16.057] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:30:0)
[10:38:16.080] Build status: STARTED
[10:38:16.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:31:0) after 2m30s
[10:40:46.152] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:31:0)
[10:40:46.170] Build status: STARTED
[10:40:46.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:32:0) after 2m30s
[10:43:16.342] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:32:0)
[10:43:16.359] Build status: STARTED
[10:43:16.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:33:0) after 5m27s
[10:48:43.382] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:33:0)
[10:48:43.398] Build status: STARTED
[10:48:43.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:34:0) after 8m33s
[10:57:16.632] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:34:0)
[10:57:16.651] Build status: STARTED
[10:57:16.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:35:0) after 5m33s
[11:02:49.998] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:35:0)
[11:02:50.043] Build status: STARTED
[11:02:50.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:36:0) after 9m1s
[11:11:51.270] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:36:0)
[11:11:51.301] Build status: STARTED
[11:11:51.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:37:0) after 3m16s
[11:15:07.436] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:37:0)
[11:15:07.462] Build status: STARTED
[11:15:07.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:38:0) after 1m12s
[11:16:19.517] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:38:0)
[11:16:19.536] Build status: STARTED
[11:16:19.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:39:0) after 5m23s
[11:21:43.036] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:39:0)
[11:21:43.053] Build status: STARTED
[11:21:43.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:40:0) after 2m15s
[11:23:58.538] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:40:0)
[11:23:58.579] Build status: STARTED
[11:23:58.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:41:0) after 5m58s
[11:29:56.819] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:41:0)
[11:29:56.838] Build status: STARTED
[11:29:56.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:42:0) after 9m28s
[11:39:24.874] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:42:0)
[11:39:24.986] Build status: STARTED
[11:39:24.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:43:0) after 7m26s
[11:46:51.013] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:43:0)
[11:46:51.030] Build status: STARTED
[11:46:51.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:44:0) after 7m34s
[11:54:25.049] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:44:0)
[11:54:25.073] Build status: STARTED
[11:54:25.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:45:0) after 6m48s
[12:01:13.093] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:45:0)
[12:01:13.340] Build status: STARTED
[12:01:13.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:46:0) after 1m21s
[12:02:34.367] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:46:0)
[12:02:34.472] Build status: STARTED
[12:02:34.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:47:0) after 1m38s
[12:04:12.563] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:47:0)
[12:04:12.607] Build status: STARTED
[12:04:12.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:48:0) after 9m9s
[12:13:21.649] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:48:0)
[12:13:21.674] Build status: STARTED
[12:13:21.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:49:0) after 5m58s
[12:19:19.827] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:49:0)
[12:19:19.846] Build status: STARTED
[12:19:19.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:50:0) after 7m57s
[12:27:16.872] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:50:0)
[12:27:16.915] Build status: STARTED
[12:27:16.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:8915856049932505104:51:0) after 8m52s
[12:28:30.371] Received PubSub notification, asking Buildbucket for the build status
[12:28:30.421] Build:
{
"id": "8750425987954229809",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxASanLibfuzzer"
},
"number": 25976,
"createdBy": "project:chromium",
"createTime": "2024-04-17T07:54:59.882726538Z",
"startTime": "2024-04-17T07:56:10.011328029Z",
"endTime": "2024-04-17T12:28:22.477119431Z",
"updateTime": "2024-04-17T12:28:22.477119431Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ea5374a96a0dd6f2433c35b2072230d50e8319ba",
"ref": "refs/heads/main"
}
}
}
[12:28:30.421] Invocation finished in 4h33m31.809297067s with status FAILED