ZFS, iTunes and "FileID race detected" error

All your general support questions for OpenZFS on OS X.

ZFS, iTunes and "FileID race detected" error

Postby roemer » Sun May 10, 2015 5:37 am

At the moment, I am indeed somewhat unlucky:
For months I had my iTunes library residing on my ZFS volume without issues, only that it suddenly stopped working today.
iTunes now only gives an error message everytime I try to start it:
"The folder containing "iTunes Library" cannot be found, and is required."
If I select my existing Music folder, which is readable via shell or Finder, I get the following:
"The selected folder cannot be found. Please choose a different folder."

The system.log contains a lot of entries as such:
"May 10 23:16:09 obelix.local coreservicesd[87]: FileID race detected: 0 assigned for ... by external allocator is already used by Automatically Add to iTunes.localized"
...
"May 10 23:25:13 obelix iTunes[3811]: assertion failed: 14C1514: libxpc.dylib + 97940 [876216DC-D5D3-381E-8AF9-49AE464E5107]: 0x89"

Anyone an idea what is going on here?

The iTunes message looks to me like a permission problem, but I am not aware to have changed any permissions.
The "FileID race detected" messages in system.log make me nervous...
roemer
 
Posts: 73
Joined: Sat Mar 15, 2014 2:32 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby realfolkblues12 » Sun May 10, 2015 12:59 pm

Have you checked the file permissions via terminal?
Do you have a snapshot you can roll back too?
Was OSX or iTunes updated before the problem started?
Have you tried creating a new test library to see if the issue persists?
realfolkblues12
 
Posts: 34
Joined: Thu Feb 12, 2015 10:41 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby roemer » Sun May 10, 2015 2:45 pm

realfolkblues12 wrote:Have you checked the file permissions via terminal?
Do you have a snapshot you can roll back too?
Was OSX or iTunes updated before the problem started?
Have you tried creating a new test library to see if the issue persists?


1) yes, including ACLs. all seems fine. I also can create files via shell on my Music dataset without a problem
2) yes, but a scrub is currently running, so I will try that later...
3) no. I did however connect and import an external ZFS disk for performing a backup around the time the problem occurred. That also involved creating new snapshots on my datasets to be backed up. Not sure yet whether this is related though...
4) yes. I could create it only on my HFS+ volume, but not on its original location. Importing (via referencing) the music files from my ZFS dataset into the new library did not work.
roemer
 
Posts: 73
Joined: Sat Mar 15, 2014 2:32 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby realfolkblues12 » Sun May 10, 2015 3:27 pm

roemer wrote:
realfolkblues12 wrote:Have you checked the file permissions via terminal?
Do you have a snapshot you can roll back too?
Was OSX or iTunes updated before the problem started?
Have you tried creating a new test library to see if the issue persists?


1) yes, including ACLs. all seems fine. I also can create files via shell on my Music dataset without a problem
2) yes, but a scrub is currently running, so I will try that later...
3) no. I did however connect and import an external ZFS disk for performing a backup around the time the problem occurred. That also involved creating new snapshots on my datasets to be backed up. Not sure yet whether this is related though...
4) yes. I could create it only on my HFS+ volume, but not on its original location. Importing (via referencing) the music files from my ZFS dataset into the new library did not work.



Not understanding your answer to question 4.
I would create a brand new library with no songs on the dataset to see if it's a zfs+iTunes issue or a corrupted library. If it is a bad library then.
I would clone out a old snapshot from when it was working and see if iTunes can read it. If it can then you can rollback assuming there is no data that you will loose in the process. If not copy the working library and overwrite the current state.

If it is not able to create a new blank library then test on a new data set(to isolate a dataset issue), then a hfs volume to eliminate iTunes issue.
realfolkblues12
 
Posts: 34
Joined: Thu Feb 12, 2015 10:41 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby lundman » Sun May 10, 2015 4:25 pm

FileID race detected: 0


Is the FileID it complains about literally "0" here? If we are returning 0, I don't think we are supposed to.

And "ls -li" in that directory should show the inode number, which is what we set FileID to.
User avatar
lundman
 
Posts: 1335
Joined: Thu Mar 06, 2014 2:05 pm
Location: Tokyo, Japan

Re: ZFS, iTunes and "FileID race detected" error

Postby roemer » Mon May 11, 2015 1:21 am

realfolkblues12 wrote:
roemer wrote:
realfolkblues12 wrote:Have you checked the file permissions via terminal?
Do you have a snapshot you can roll back too?
Was OSX or iTunes updated before the problem started?
Have you tried creating a new test library to see if the issue persists?


1) yes, including ACLs. all seems fine. I also can create files via shell on my Music dataset without a problem
2) yes, but a scrub is currently running, so I will try that later...
3) no. I did however connect and import an external ZFS disk for performing a backup around the time the problem occurred. That also involved creating new snapshots on my datasets to be backed up. Not sure yet whether this is related though...
4) yes. I could create it only on my HFS+ volume, but not on its original location. Importing (via referencing) the music files from my ZFS dataset into the new library did not work.



Not understanding your answer to question 4.
I would create a brand new library with no songs on the dataset to see if it's a zfs+iTunes issue or a corrupted library. If it is a bad library then.
I would clone out a old snapshot from when it was working and see if iTunes can read it. If it can then you can rollback assuming there is no data that you will loose in the process. If not copy the working library and overwrite the current state.

If it is not able to create a new blank library then test on a new data set(to isolate a dataset issue), then a hfs volume to eliminate iTunes issue.


The following is working for me:
Cloning the last snapshot into the tank's root, and then directing iTunes to use that:
Code: Select all
  sudo zfs clone ztank/Musik@Backup2015-05-10 ztank/MusicClone
  ln -s /Volumes/ZTank/MusicClone ~/Music
  open iTunes


That starts iTunes as usual.

My normal setting has the very same snapshot (ztank/Musik@Backup2015-05-10) mounted under /Users/Shared/Music and then I have a symbolic link from my home directory.
This does not work at the moment, but rather when trying to start iTunes for /Users/Shared/Music, I get the FileID error messages in my system log.
Noteworthwhile, this all worked up-to my snapshot and backup creation yesterday....

I am currently running the 1.3.2RC1 version which I had however only installed after iTunes stopped working yesterday.
Yesterday, I tried both 1.3.1-r2 and 1.3.2RC1, but to no avail - both did show the same behaviour.

The original, currently de-funct Music dataset has the following settings:
Code: Select all
bash-3.2$ zfs get all ztank/Music
NAME         PROPERTY               VALUE                  SOURCE
ztank/Music  type                   filesystem             -
ztank/Music  creation               Mon Apr 14 22:52 2014  -
ztank/Music  used                   141G                   -
ztank/Music  available              2.69T                  -
ztank/Music  referenced             126G                   -
ztank/Music  compressratio          1.00x                  -
ztank/Music  mounted                yes                    -
ztank/Music  quota                  none                   default
ztank/Music  reservation            none                   default
ztank/Music  recordsize             128K                   default
ztank/Music  mountpoint             /Users/Shared/Music    local
ztank/Music  sharenfs               off                    default
ztank/Music  checksum               on                     default
ztank/Music  compression            off                    default
ztank/Music  atime                  off                    inherited from ztank
ztank/Music  devices                on                     default
ztank/Music  exec                   on                     default
ztank/Music  setuid                 on                     default
ztank/Music  readonly               off                    default
ztank/Music  zoned                  off                    default
ztank/Music  snapdir                hidden                 default
ztank/Music  aclmode                discard                default
ztank/Music  aclinherit             restricted             default
ztank/Music  canmount               on                     default
ztank/Music  xattr                  on                     default
ztank/Music  copies                 1                      default
ztank/Music  version                5                      -
ztank/Music  utf8only               on                     -
ztank/Music  normalization          formD                  -
ztank/Music  casesensitivity        insensitive            -
ztank/Music  vscan                  off                    default
ztank/Music  nbmand                 off                    default
ztank/Music  sharesmb               off                    default
ztank/Music  refquota               none                   default
ztank/Music  refreservation         none                   default
ztank/Music  primarycache           all                    default
ztank/Music  secondarycache         all                    default
ztank/Music  usedbysnapshots        14.4G                  -
ztank/Music  usedbydataset          126G                   -
ztank/Music  usedbychildren         0                      -
ztank/Music  usedbyrefreservation   0                      -
ztank/Music  logbias                latency                default
ztank/Music  dedup                  off                    default
ztank/Music  mlslabel               none                   default
ztank/Music  sync                   standard               default
ztank/Music  refcompressratio       1.00x                  -
ztank/Music  written                1.88M                  -
ztank/Music  logicalused            140G                   -
ztank/Music  logicalreferenced      126G                   -
ztank/Music  snapdev                hidden                 default
ztank/Music  com.apple.browse       on                     default
ztank/Music  com.apple.ignoreowner  off                    default
ztank/Music  com.apple.mimic_hfs    on                     inherited from ztank
ztank/Music  redundant_metadata     all                    default
ztank/Music  overlay                off                    default


EDIT: I have now changed the mount point of this dataset to /Users/<myself>/Music, removing the need for another symbolic link in my home directory and voila - works... Strange.
Last edited by roemer on Mon May 11, 2015 4:08 am, edited 2 times in total.
roemer
 
Posts: 73
Joined: Sat Mar 15, 2014 2:32 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby roemer » Mon May 11, 2015 1:23 am

lundman wrote:
FileID race detected: 0


Is the FileID it complains about literally "0" here? If we are returning 0, I don't think we are supposed to.

And "ls -li" in that directory should show the inode number, which is what we set FileID to.


Yes, it indeed did generate quite a number of this FileID 0 'race detections':
Code: Select all
...
May 11 20:14:34 obelix.local coreservicesd[87]: FileID race detected: 0 assigned for Queen by external allocator is already used by Automatically Add to iTunes.localized
May 11 20:14:34 obelix.local coreservicesd[87]: FileID race detected: 0 assigned for Alicia Keys by external allocator is already used by Automatically Add to iTunes.localized
May 11 20:14:45 obelix.local coreservicesd[87]: FileID race detected: 0 assigned for .TemporaryItems by external allocator is already used by Automatically Add to iTunes.localized
May 11 20:14:45 obelix.local coreservicesd[87]: FileID race detected: 0 assigned for .Trashes by external allocator is already used by Automatically Add to iTunes.localized


According to ls -i, none of the files in my Music folder has inode 0, nor does 'Music/iTunes/iTunes Media/Automatically Add to iTunes.localized' .

PS: I changed now my mount point of that dataset, which seemed to have helped...
PPS: After re-attaching my external ZFS Backup disk to cross-check yesterday's backup, the issues occur again as described in my previous posts.
Can it be that there's an incompatibility with this second zfs pool?
How can I debug this?
roemer
 
Posts: 73
Joined: Sat Mar 15, 2014 2:32 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby wgscott » Mon Oct 12, 2015 7:02 pm

I wonder if this is an iTunes problem rather than a zfs. I am having similar issues on HFS+. However, I just moved my iTunes library (the database file) to a different physical disk, and (so far at least) the problem has disappeared.
wgscott
 
Posts: 1
Joined: Thu Oct 08, 2015 5:42 pm

Re: ZFS, iTunes and "FileID race detected" error

Postby ilovezfs » Fri Nov 06, 2015 10:53 pm

Searching Google, this seems to be a generic problem that has variously affected iTunes, Finder, Spotlight, OmniGraffle, among others, on HFS+, on Tuxera NTFS, on ZFS, etc.

The common theme is that something is on an external or network drive.

I'm wondering if this happens in any of these cases:
1) the entire home directory is on ZFS
2) the entire home directory is on an HFS+ ZVOL
3) Both ~/Library and ~/Music/iTunes are on the same dataset
4) The ~/Music/iTunes folder is accessed only via SMB2 or AFP
ilovezfs
 
Posts: 232
Joined: Thu Mar 06, 2014 7:58 am


Return to General Help

Who is online

Users browsing this forum: Google [Bot] and 24 guests