Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

SourceForge Headquarters 225 Broadway Suite 1600 San Diego, CA 92101 +1 (858) 422-6466

Honestly Paul, before going to be this morning I really didn’t have any ideas on what to look at.  The solution (setting a busy timeout) that James came up with seems to be a good stopgap measure and should get into 3.0.1 (IMO).

From: Paul Licameli <pau...@gm...> 
Sent: Thursday, April 8, 2021 6:58 AM
To: aud...@li...
Subject: Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

Jack, can you describe a precise sequence of reproducible steps?  When you say “open” a file, tell us exactly what that means — dragging it onto an Audacity window or using a file dialog or something else,

Leland, are you thinking as I am that this involves a short lived Audacity process that results only when you click an icon or use its context menu?

I have got anecdotal word that the import problem can be on Mac too.

PRL 

On Thursday, April 8, 2021, Jack L. <xxj...@gm... <mailto:xxj...@gm...> > wrote:

right click filename, open with audacity, then combo of ctrl+o inside audacity and import audio. When the error message came up, it was a ctrl+o operation.

On Thu, Apr 8, 2021 at 12:23 AM Leland <ll...@ho... <mailto:ll...@ho...> > wrote:

Thanks Jack.  It’s pretty perplexing though.  I don’t understand why the log entries are out of order.  Could be that these two messages were buffered until the logger was initialized:

13:28:05: sqlite3 message: (261) database is locked in "PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;"

13:28:05: Failed to set mode on C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-28-05 N-1.aup3unsaved

How did you start Audacity?  From the start menu or by double clicking an project file?

From: Jack L. <xxj...@gm... <mailto:xxj...@gm...> > 
Sent: Thursday, April 8, 2021 1:55 AM
To: Audacity-Devel list <aud...@li... <mailto:aud...@li...> >
Subject: Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

The install, here's the lastlog

13:28:06: Audacity 3.0.1
13:28:06: Trying to load FFmpeg libraries...
13:28:06: Trying to load FFmpeg libraries from default path, 'C:\Program Files (x86)\FFmpeg for Audacity\avformat-55.dll'.
13:28:06: Looking up PATH environment variable...
13:28:06: PATH = 'C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\ProgramData\chocolatey\bin;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\PuTTY\;C:\Users\jlow\AppData\Local\Microsoft\WindowsApps;C:\Program Files\smartmontools\bin'
13:28:06: Temporarily prepending ';C:\Program Files (x86)\FFmpeg for Audacity' to PATH...
13:28:06: Checking for monolithic avformat from 'C:\Program Files (x86)\FFmpeg for Audacity\avformat-55.dll'.
13:28:06: Error: Couldn't find symbol 'avutil_version' in a dynamic library (error 127: The specified procedure could not be found.)
13:28:06: Error: Couldn't find symbol 'avcodec_version' in a dynamic library (error 127: The specified procedure could not be found.)
13:28:06: avformat not monolithic
13:28:06: Loading avutil from 'avutil-52.dll'.
13:28:06: Loading avcodec from 'avcodec-55.dll'.
13:28:06: Loading avformat from 'C:\Program Files (x86)\FFmpeg for Audacity\avformat-55.dll'.
13:28:06: Actual avutil path C:\Program Files (x86)\FFmpeg for Audacity\avutil-52.dll
13:28:06: Actual avcodec path C:\Program Files (x86)\FFmpeg for Audacity\avcodec-55.dll
13:28:06: Actual avformat path C:\Program Files (x86)\FFmpeg for Audacity\avformat-55.dll
13:28:06: Importing symbols...
13:28:06: All symbols loaded successfully. Initializing the library.
13:28:06: Retrieving FFmpeg library version numbers:
13:28:06:    AVCodec version 0x373466 - 55.52.102 (built against 0x373466 - 55.52.102)
13:28:06:    AVFormat version 0x372164 - 55.33.100 (built against 0x372164 - 55.33.100)
13:28:06:    AVUtil version 0x344264 - 52.66.100 (built against 0x344264 - 52.66.100)
13:28:06: Returning PATH to previous setting: C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\ProgramData\chocolatey\bin;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\PuTTY\;C:\Users\jlow\AppData\Local\Microsoft\WindowsApps;C:\Program Files\smartmontools\bin
13:28:06: FFmpeg libraries loaded successfully.
13:28:06: File name is C:\Users\jlow\Desktop\Bodoni - Lipstick.mp3
13:28:06: Mime type is *
13:28:06: Opening with libmad
13:28:06: Open(C:\Users\jlow\Desktop\Bodoni - Lipstick.mp3) succeeded
13:28:07: File name is C:\Users\jlow\Desktop\Bodoni - Influencer Influenza.mp3
13:28:07: Mime type is *
13:28:07: Opening with libmad
13:28:07: Open(C:\Users\jlow\Desktop\Bodoni - Influencer Influenza.mp3) succeeded
13:28:05: sqlite3 message: (261) database is locked in "PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;"
13:28:05: Failed to set mode on C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-28-05 N-1.aup3unsaved
Error: query aborted
SQL: PRAGMA main.locking_mode = SHARED;PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;
13:28:18: File name is C:\Users\jlow\Desktop\21stpunk1endcredits.mp4
13:28:18: Mime type is *
13:28:18: Opening with libav
13:28:18: Open(C:\Users\jlow\Desktop\21stpunk1endcredits.mp4) succeeded
13:28:17: sqlite3 message: (261) database is locked in "PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;"
13:28:17: Failed to set mode on C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-28-17 N-2.aup3unsaved
Error: query aborted
SQL: PRAGMA main.locking_mode = SHARED;PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;
13:28:29: File name is C:\Users\jlow\Desktop\0ca2af87641e21c6ff89ffadcf4725402078e43e.mp4
13:28:29: Mime type is *
13:28:29: Opening with libav
13:28:29: Open(C:\Users\jlow\Desktop\0ca2af87641e21c6ff89ffadcf4725402078e43e.mp4) succeeded
13:28:29: sqlite3 message: (261) database is locked in "PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;"
13:28:29: Failed to set mode on C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-28-29 N-3.aup3unsaved
Error: query aborted
SQL: PRAGMA main.locking_mode = SHARED;PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;
13:28:39: File name is C:\Users\jlow\Desktop\21stpunk1endcredits.mp4
13:28:39: Mime type is *
13:28:39: Opening with libav
13:28:39: Open(C:\Users\jlow\Desktop\21stpunk1endcredits.mp4) succeeded
13:28:44: DBConnection SetDBError
ErrorCode: 5
LastError: Failed to execute a project file command:

SELECT Count(*) FROM sqlite_master WHERE type='table';
LibraryError: database is locked
13:29:56: File name is C:\Users\jlow\Desktop\21stpunk2credits.mp4
13:29:56: Mime type is *
13:29:56: Opening with libav
13:29:56: Open(C:\Users\jlow\Desktop\21stpunk2credits.mp4) succeeded
13:30:30: File name is C:\Users\jlow\Desktop\21stpunk1traileraws.avi
13:30:30: Mime type is *
13:30:30: Opening with libav
13:30:30: Open(C:\Users\jlow\Desktop\21stpunk1traileraws.avi) succeeded
13:30:30: sqlite3 message: (261) database is locked in "PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;"
13:30:30: Failed to set mode on C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-30-30 N-5.aup3unsaved
Error: query aborted
SQL: PRAGMA main.locking_mode = SHARED;PRAGMA main.synchronous = NORMAL;PRAGMA main.journal_mode = WAL;PRAGMA main.wal_autocheckpoint = 0;

On Wed, Apr 7, 2021 at 6:04 PM Leland <ll...@ho... <mailto:ll...@ho...> > wrote:

Are you using a “portable” version of Audacity or do you install?  If portable, then you’ll find the lastlog.txt file inside your portable directory.  If you install Audacity, then you should find it here:

C:\Users\jlow\AppData\Roaming\Audacity

From: Jack L. <xxj...@gm... <mailto:xxj...@gm...> > 
Sent: Wednesday, April 7, 2021 7:31 PM
To: Audacity-Devel list <aud...@li... <mailto:aud...@li...> >
Subject: Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

I might be looking in the wrong place

C:\Users\jlow\AppData\Local\Audacity\SessionData\New Project 2021-04-07 13-28-44 N-4.aup3unsaved

is the only thing i found in AppData

On Wed, Apr 7, 2021 at 5:19 PM Leland <ll...@ho... <mailto:ll...@ho...> > wrote:

Not finding the lastlog file is rather interesting by itself.  It should be there.  One of the last things that Audacity does when it exits is dump the log to that file.  The only reason I can think of that it might not be doing that is that Audacity is not ending cleanly.

James has come up with an idea on how to resolve the open error, but I’m still going to look into why it’s happening.  It really shouldn’t be.  But, whether I find the real cause or not, we’ll put in James’s solution.

From: Jack L. <xxj...@gm... <mailto:xxj...@gm...> > 
Sent: Wednesday, April 7, 2021 5:34 PM
To: Audacity-Devel list <aud...@li... <mailto:aud...@li...> >
Subject: Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

Not able to find the lastlog but I seem to run into the issue pretty frequently just by opening/importing files in multiple windows. Maybe that is the key.

Seems to be fairly easy to reproduce on FreeBSD and Windows but it doesn't seem to happen in any particular sequence but it always happens during an open file via ctrl+o type open from what I can tell.

On Wed, Apr 7, 2021 at 3:10 PM Leland <ll...@ho... <mailto:ll...@ho...> > wrote:

I was able to reproduce your error through some trickery:

But, what’s interesting about this is that it’s not as simple as I first thought.  If it had been a simple file locking issue, then we could have just increased the number of retries that sqlite performs until the operation succeeds.

However, this is not a “plain” file locking issue.  It’s a “database” locking issue where two processes/threads are trying to use the database concurrently.  Almost as if two Audacity’s were running and fiddling with the same aup3.  (I know that’s not the case.)

I was able to reproduce the same message by holding an active “write” transaction using the “sqlite3” command line utility.  If I use the same utility to hold a “read” transaction open, then the problem doesn’t happen.  That suggests that something is writing to the database and, since we can probably assume it’s not some other application, it must be Audacity, maybe something in a different thread.

Are you able to reproduce it Jack?  Do you remember the exact steps?  No biggie if you can’t since this is already a great help, but if you can, then I’d be interesting to see your “%APPDATA\audacity\lastlog.txt” file after you get the error and close Audacity. (the full log is saved at Audacity exit.)

Again, thanks for letting us know.

> -----Original Message-----

> From: Jack L. <xxj...@gm... <mailto:xxj...@gm...> >

> Sent: Wednesday, April 7, 2021 3:31 PM

> To: Audacity-Devel list <aud...@li... <mailto:aud...@li...> >

> Subject: Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

> 

> On windows 10, I just opened a mp3, then imported an mp3, then opened an

> mp4 and "Error opening a new empty project". Show Log shows:

> 

> 13:28:39: File name is C:\Users\jlow\Desktop\21stpunk1endcredits.mp4

> 13:28:39: Mime type is *

> 13:28:39: Opening with libav

> 13:28:39: Open(C:\Users\jlow\Desktop\21stpunk1endcredits.mp4) succeeded

> 13:28:44: DBConnection SetDBError

>     ErrorCode: 5

>     LastError: Failed to execute a project file command:

> 

> SELECT Count(*) FROM sqlite_master WHERE type='table';

>     LibraryError: database is locked

> 

> 

> Clicked ok and now it says "Connection to project file is null".

> 

> 

> Seems to work again after closing audacity and reopening.

> 

> 

> On Wed, Apr 7, 2021 at 11:00 AM James Crook < <mailto:jam...@gm...> jam...@gm...>

> wrote:

> >

> >

> > I've just completed making Audacity 3.0.1 Release Candidate 01.

> > It's available for testing from

> >  <https://www.fosshub.com/Audacity-devel.html> https://www.fosshub.com/Audacity-devel.html

> >

> > This page says what's new; it's mostly fixes to 3.0.0.

> >  <https://alphamanual.audacityteam.org/man/New_features_in_this_release> https://alphamanual.audacityteam.org/man/New_features_in_this_release

> >

> > The other important change is better error reporting, especially the 'Show

> Log' button.

> > Please give this build a good test, and if you do get the new extended error

> messages we want to know the details of the "Show Log..."

> >

> > --James

> >

> >

> >

> >

> > Checksums:

> > ----------------

> >

> > When you've downloaded an RC you can check the checksums before

> running here:

> >  <https://md5file.com/calculator> https://md5file.com/calculator

> >

> >

> > audacity-win-3.0.1rc01.exe (application/x-msdownload) - 29491024 bytes

> > SHA-256

> >

> b41b945c919479ad57321da835b31cb63b172b3d4318962eb926ab69a21896c

> 5

> >

> > audacity-macos-3.0.1rc01.dmg (n/a) - 41505451 bytes

> > SHA-256

> >

> ce01b48d7c846503da22b01b01a93eb1ec8d6811c16023b196a555fae514669f

> >

> > audacity-minsrc-3.0.1rc01.tar.xz (n/a) - 13329344 bytes

> > SHA-256

> >

> ea541d874abad6e78a0d721cb5bdc87cc6677bdaa59fbb99b9a2317a90e76e2c

> >

> > audacity-3.0.1rc01.zip (application/x-zip-compressed) - 12587511 bytes

> > SHA-256

> >

> 1955c3e6b029192e7a2c7feec8845777dd783c86da7d018f581034eeaec562a9

> >

> > audacity-manual-3.0.1rc01.zip (application/x-zip-compressed) -

> > 23198502 bytes

> > SHA-256

> > 126b1edf0730f722ad4e58a402ee6d4af741dea38426def289d94af45aaf70ec

> >

> > _______________________________________________

> > audacity-devel mailing list

> >  <mailto:aud...@li...> aud...@li...

> >  <https://lists.sourceforge.net/lists/listinfo/audacity-devel> https://lists.sourceforge.net/lists/listinfo/audacity-devel

> 

> 

> _______________________________________________

> audacity-devel mailing list

>  <mailto:aud...@li...> aud...@li...

>  <https://lists.sourceforge.net/lists/listinfo/audacity-devel> https://lists.sourceforge.net/lists/listinfo/audacity-devel

_______________________________________________
audacity-devel mailing list
aud...@li... <mailto:aud...@li...> 
https://lists.sourceforge.net/lists/listinfo/audacity-devel

Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)

A free multi-track audio editor and recorder

Re: [Audacity-devel] Audacity 3.0.1 RC01 (for testing only)