Unarchive not deleting first time

Get help. Get answers. Let others lend you a hand.

Moderator: Mr_Noodle

Unarchive not deleting first time Tue Mar 12, 2019 6:20 am • by makmanuk
Hey all,

Had a search through the forums but couldn't find anyone with the same issue. I'm a fairly new Hazel user so this could be an issue with my set up but I don't remember this happening at the start, it seems to be a recent phenomenon.

I have a download folder into which Hazel unarchives any downloaded zip files and then deletes the zip file. However, Hazel seems to do the unarchive correctly but doesn't delete the zip first time. It will then run again, create a second unarchived folder (name-1) and then delete the zip, so I end up with duplicate folders. I'f I make no changes to that folder, it's fine as Hazel will then delete the duplicate but more often that not I modify one of the files so we end up with 2 folders.

Hope someone can help.

Thanks.
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Tue Mar 12, 2019 11:20 am • by Mr_Noodle
Are you using Hazel's Unarchive action? That should throw away the original for you. If not, then can you post what method you are using to do the unarchive?
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Mon Mar 18, 2019 9:18 am • by makmanuk
Mr_Noodle wrote:Are you using Hazel's Unarchive action? That should throw away the original for you. If not, then can you post what method you are using to do the unarchive?


Apologies for the slow reply!

Yes, I am using the unarchive action.

Image
Image
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Mon Mar 18, 2019 11:30 am • by Mr_Noodle
Can you check the logs and post/email a relevant excerpt?
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Mon Mar 18, 2019 11:54 am • by makmanuk
2019-03-18 15:49:26.209 hazelworker[24381] Running worker (v4.3.4) for folder with identifier: 16777219-603829.
2019-03-18 15:49:26.396 hazelworker[24381] ###main load address: 0x100879000
2019-03-18 15:49:26.396 hazelworker[24381] ###Noodle load address: 0x1009a3000
2019-03-18 15:49:26.396 hazelworker[24381] ###CK load address: 0x100962000
2019-03-18 15:49:27.044 hazelworker[24381] Processing folder Downloads
2019-03-18 15:49:29.111 hazelworker[24381] reinformationforplanningapplication.zip: Rule Unarchive and Delete matched.
2019-03-18 15:49:29.164 hazelworker[24381] [File Event] File unarchived: /Users/Moiz/Downloads/reinformationforplanningapplication.zip unarchived to /Users/Moiz/Downloads/reinformationforplanningapplication-1.
2019-03-18 15:49:29.177 hazelworker[24381] File .DS_Store is busy. Skipping for now.
2019-03-18 15:49:29.180 hazelworker[24381] File reinformationforplanningapplication is busy. Skipping for now.
2019-03-18 15:49:30.208 hazelworker[24390] Running worker (v4.3.4) for folder with identifier: trash.
2019-03-18 15:49:30.210 hazelworker[24390] ###main load address: 0x10876a000
2019-03-18 15:49:30.210 hazelworker[24390] ###Noodle load address: 0x108893000
2019-03-18 15:49:30.210 hazelworker[24390] ###CK load address: 0x108853000
2019-03-18 15:49:30.220 hazelworker[24390] Processing folder Trash
2019-03-18 15:49:31.223 hazelworker[24381] reinformationforplanningapplication-1: Rule Today - Red matched.
2019-03-18 15:49:31.407 hazelworker[24390] Done processing folder Trash
2019-03-18 15:49:33.979 hazelworker[24381] reinformationforplanningapplication: Rule Today - Red matched.
2019-03-18 15:49:40.287 hazelworker[24381] Done processing folder Downloads

I think that is the whole of the relevant bit.

Image
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Tue Mar 19, 2019 10:50 am • by Mr_Noodle
Can you find a log excerpt the first time it's unarchived? It seems like the old unarchived folder is already there in this example.
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Wed Mar 20, 2019 7:06 am • by makmanuk
2019-03-20 11:02:37.768 hazelworker[27956] Running worker (v4.3.4) for folder with identifier: 16777219-603829.
2019-03-20 11:02:37.771 hazelworker[27956] ###main load address: 0x1071a8000
2019-03-20 11:02:37.771 hazelworker[27956] ###Noodle load address: 0x1072cc000
2019-03-20 11:02:37.771 hazelworker[27956] ###CK load address: 0x107291000
2019-03-20 11:02:37.804 hazelworker[27956] Processing folder Downloads
2019-03-20 11:02:39.886 hazelworker[27956] File Unconfirmed 534060.crdownload is busy. Skipping for now.
2019-03-20 11:02:42.282 hazelworker[27956] File Unconfirmed 534060.crdownload is busy. Skipping for now.
2019-03-20 11:02:44.663 hazelworker[27956] File Unconfirmed 534060.crdownload is busy. Skipping for now.
2019-03-20 11:02:48.948 hazelworker[27956] File Unconfirmed 534060.crdownload is busy. Skipping for now.
2019-03-20 11:02:53.162 hazelworker[27956] File .DS_Store is busy. Skipping for now.
2019-03-20 11:02:53.165 hazelworker[27956] File asharalondondraftempandsupplementaryevidenceforsag2.zip is busy. Skipping for now.
2019-03-20 11:02:53.220 hazelworker[27956] File asharalondondraftempandsupplementaryevidenceforsag2 is busy. Skipping for now.
2019-03-20 11:03:01.290 hazelworker[27956] asharalondondraftempandsupplementaryevidenceforsag2.zip: Rule Unarchive and Delete matched.
2019-03-20 11:03:01.423 hazelworker[27956] [File Event] File unarchived: /Users/Moiz/Downloads/asharalondondraftempandsupplementaryevidenceforsag2.zip unarchived to /Users/Moiz/Downloads/asharalondondraftempandsupplementaryevidenceforsag2-1.
2019-03-20 11:03:01.445 hazelworker[27956] asharalondondraftempandsupplementaryevidenceforsag2: Rule Today - Red matched.
2019-03-20 11:03:02.478 hazelworker[27980] Running worker (v4.3.4) for folder with identifier: trash.
2019-03-20 11:03:02.480 hazelworker[27980] ###main load address: 0x107595000
2019-03-20 11:03:02.480 hazelworker[27980] ###Noodle load address: 0x1076b6000
2019-03-20 11:03:02.480 hazelworker[27980] ###CK load address: 0x10767b000
2019-03-20 11:03:02.496 hazelworker[27980] Processing folder Trash
2019-03-20 11:03:03.620 hazelworker[27980] Done processing folder Trash
2019-03-20 11:03:11.467 hazelworker[27956] asharalondondraftempandsupplementaryevidenceforsag2-1: Rule Today - Red matched.
2019-03-20 11:03:19.736 hazelworker[27956] Done processing folder Downloads

Hi,

So this is a log for a file I have just downloaded. It's strange, the file unarchives twice, the first time correctly, but doesn't delete the zip file. The second time it creates the duplicate folder (named xxx-1) and deletes the archive as per the log.
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Wed Mar 20, 2019 10:17 am • by Mr_Noodle
It looks like it is only unarchiving once. There still seems to be the issue, though, of the unarchived contents already existing as it has to tack on a "-1" to the end.
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Wed Mar 20, 2019 12:08 pm • by makmanuk
Image

This is a gif of a downloaded zip file and what happens in the folder. I hope this helps.
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Thu Mar 21, 2019 10:37 am • by Mr_Noodle
Turn on debug mode as described here: https://www.noodlesoft.com/kb/hazel-debug-mode/

After that, try triggering the bug again and send me the full logs for the zip file in question.
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Thu Mar 21, 2019 1:24 pm • by makmanuk
2019-03-21 17:22:04.331 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-21 17:22:04 +0000";
path = "/Users/Moiz/Downloads/.com.google.Chrome.MiWFCa";
shouldDoFullScan = 0;
},
{
date = "2019-03-21 17:22:04 +0000";
path = "/Users/Moiz/Downloads/Unconfirmed 886143.crdownload";
shouldDoFullScan = 0;
},
{
date = "2019-03-21 17:22:04 +0000";
path = "/Users/Moiz/Downloads/164ladbrokeroadcheckin.zip";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-21 17:22:04.331 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/.com.google.Chrome.MiWFCa:, No such file or directory
2019-03-21 17:22:04.332 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/Unconfirmed 886143.crdownload:, No such file or directory
2019-03-21 17:22:04.332 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-21 17:22:04.402 hazelworker[30939] Running worker (v4.3.4) for folder with identifier: 16777219-603829.
2019-03-21 17:22:04.405 hazelworker[30939] ###main load address: 0x108b5d000
2019-03-21 17:22:04.405 hazelworker[30939] ###Noodle load address: 0x108c83000
2019-03-21 17:22:04.405 hazelworker[30939] ###CK load address: 0x108c44000
2019-03-21 17:22:04.416 hazelworker[30939] DEBUG: Program is licensed.
2019-03-21 17:22:04.446 hazelworker[30939] DEBUG: Could not get modfication date of Safari prefs file /Users/Moiz/Library/Preferences/com.apple.Safari.plist: Error Domain=NSCocoaErrorDomain Code=260 "The file “com.apple.Safari.plist” couldn’t be opened because there is no such file." UserInfo={NSURL=file:///Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSFilePath=/Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSUnderlyingError=0x7fcc15e37030 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-21 17:22:04.456 hazelworker[30939] DEBUG: Chrome preference file not found.
2019-03-21 17:22:04.459 hazelworker[30939] DEBUG: Error reading file /Users/Moiz/Library/Application Support/Firefox/prefs.js: Error Domain=NSCocoaErrorDomain Code=260 "The file “prefs.js” couldn’t be opened because there is no such file." UserInfo={NSFilePath=/Users/Moiz/Library/Application Support/Firefox/prefs.js, NSUnderlyingError=0x7fcc15e347d0 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-21 17:22:04.466 hazelworker[30939] Processing folder Downloads
2019-03-21 17:22:04.466 hazelworker[30939] DEBUG: Pausing to wait for things to settle down.
2019-03-21 17:22:05.332 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-21 17:22:05 +0000";
path = "/Users/Moiz/Downloads/.BAH.hpEe8";
shouldDoFullScan = 0;
},
{
date = "2019-03-21 17:22:05 +0000";
path = "/Users/Moiz/Downloads/164ladbrokeroadcheckin";
shouldDoFullScan = 0;
},
{
date = "2019-03-21 17:22:05 +0000";
path = "/Users/Moiz/Downloads/.DS_Store";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-21 17:22:05.332 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/.BAH.hpEe8:, No such file or directory
2019-03-21 17:22:05.332 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-21 17:22:05.332 HazelHelper[363] DEBUG: Task already running for folder: /Users/Moiz/Downloads
2019-03-21 17:22:06.468 hazelworker[30939] DEBUG: Processing directories: (
"/Users/Moiz/Downloads"
)
2019-03-21 17:22:06.471 HazelHelper[363] DEBUG: Checking events for path /Users/Moiz/Downloads, folder Downloads
2019-03-21 17:22:06.472 hazelworker[30939] DEBUG: Received file event: {
date = "2019-03-21 17:22:05 +0000";
path = "<ComNoodlesoft_NoodlePathSet: 0x7fcc15f03c30>\n /Users/Moiz/Downloads/164ladbrokeroadcheckin.zip : 0\n /Users/Moiz/Downloads/.BAH.hpEe8 : 0\n /Users/Moiz/Downloads/164ladbrokeroadcheckin : 0\n /Users/Moiz/Downloads/Unconfirmed 886143.crdownload : 0\n /Users/Moiz/Downloads/.com.google.Chrome.MiWFCa : 0\n /Users/Moiz/Downloads/.DS_Store : 0\n";
}
2019-03-21 17:22:06.472 hazelworker[30939] DEBUG: About to process directory /Users/Moiz/Downloads
2019-03-21 17:22:06.519 hazelworker[30939] DEBUG: 164ladbrokeroadcheckin.zip: Did not match any rules.
2019-03-21 17:22:06.519 hazelworker[30939] DEBUG: .DS_Store: File is hidden/invisible. Skipping.
2019-03-21 17:22:06.520 hazelworker[30939] DEBUG: .localized: File is hidden/invisible. Skipping.
2019-03-21 17:22:06.523 hazelworker[30939] DEBUG: 164ladbrokeroadcheckin: Did not match any rules.
2019-03-21 17:22:06.523 hazelworker[30939] DEBUG: ~$entManagementPlan.doc: File is hidden/invisible. Skipping.
2019-03-21 17:22:06.523 hazelworker[30939] DEBUG: .com.google.Chrome.BU04fP: File is hidden/invisible. Skipping.
2019-03-21 17:22:06.524 hazelworker[30939] DEBUG: ~$hara 1441h_190219.docx: File is hidden/invisible. Skipping.
2019-03-21 17:22:06.524 hazelworker[30939] DEBUG: Writing out DB file for /Users/Moiz/Downloads to path: /Users/Moiz/Library/Application Support/Hazel/16777219-603829.hazeldb
2019-03-21 17:22:06.525 hazelworker[30939] DEBUG: Directory /Users/Moiz/Downloads processed in 0.052580 seconds
2019-03-21 17:22:06.526 HazelHelper[363] DEBUG: Checking events for path /Users/Moiz/Downloads, folder Downloads
2019-03-21 17:22:06.526 hazelworker[30939] DEBUG: Sending metrics to scheduler. Next scheduled run: 4001-01-01 00:00:00.000
2019-03-21 17:22:06.526 HazelHelper[363] DEBUG: Received metrics for folder /Users/Moiz/Downloads: {
directoryDepth = 0;
requestedSchedulingTime = "4001-01-01 00:00:00 +0000";
triggerPaths = "<ComNoodlesoft_NoodlePathSet: 0x6000006814a0>\n";
unavailablePaths = "{(\n)}";
}
2019-03-21 17:22:06.527 HazelHelper[363] DEBUG: Timer scheduled for folder /Users/Moiz/Downloads at 4001-01-01 00:00:00 +0000
2019-03-21 17:22:06.527 hazelworker[30939] Done processing folder Downloads
2019-03-21 17:22:06.530 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Task removed: [30939]



In order to reduce the amount of info in the log I turned off all actions except the unarchive one. I then also cleared the download folder of all files. Then I downloaded the file. This time the zip unarchived but didn't delete but also did not create a second copy.
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Fri Mar 22, 2019 10:50 am • by Mr_Noodle
I'm not seeing any log messages referring to the unarchive. Can you re-check the logs?
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City

Re: Unarchive not deleting first time Fri Mar 22, 2019 12:56 pm • by makmanuk
2019-03-22 16:55:06.298 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-22 16:55:06 +0000";
path = "/Users/Moiz/Downloads/.com.google.Chrome.k0YOki";
shouldDoFullScan = 0;
},
{
date = "2019-03-22 16:55:06 +0000";
path = "/Users/Moiz/Downloads/Unconfirmed 785859.crdownload";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-22 16:55:06.298 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/.com.google.Chrome.k0YOki:, No such file or directory
2019-03-22 16:55:06.299 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-22 16:55:06.390 hazelworker[33552] Running worker (v4.3.4) for folder with identifier: 16777219-603829.
2019-03-22 16:55:06.393 hazelworker[33552] ###main load address: 0x103f9f000
2019-03-22 16:55:06.393 hazelworker[33552] ###Noodle load address: 0x1040c5000
2019-03-22 16:55:06.393 hazelworker[33552] ###CK load address: 0x10408a000
2019-03-22 16:55:06.402 hazelworker[33552] DEBUG: Program is licensed.
2019-03-22 16:55:06.414 hazelworker[33552] DEBUG: Could not get modfication date of Safari prefs file /Users/Moiz/Library/Preferences/com.apple.Safari.plist: Error Domain=NSCocoaErrorDomain Code=260 "The file “com.apple.Safari.plist” couldn’t be opened because there is no such file." UserInfo={NSURL=file:///Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSFilePath=/Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSUnderlyingError=0x7fb809405940 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-22 16:55:06.418 hazelworker[33552] DEBUG: Chrome preference file not found.
2019-03-22 16:55:06.419 hazelworker[33552] DEBUG: Error reading file /Users/Moiz/Library/Application Support/Firefox/prefs.js: Error Domain=NSCocoaErrorDomain Code=260 "The file “prefs.js” couldn’t be opened because there is no such file." UserInfo={NSFilePath=/Users/Moiz/Library/Application Support/Firefox/prefs.js, NSUnderlyingError=0x7fb809634650 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-22 16:55:06.424 hazelworker[33552] Processing folder Downloads
2019-03-22 16:55:06.424 hazelworker[33552] DEBUG: Pausing to wait for things to settle down.
2019-03-22 16:55:07.296 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-22 16:55:07 +0000";
path = "/Users/Moiz/Downloads/Unconfirmed 785859.crdownload";
shouldDoFullScan = 0;
},
{
date = "2019-03-22 16:55:07 +0000";
path = "/Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-22 16:55:07.296 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/Unconfirmed 785859.crdownload:, No such file or directory
2019-03-22 16:55:07.297 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-22 16:55:07.297 HazelHelper[363] DEBUG: Task already running for folder: /Users/Moiz/Downloads
2019-03-22 16:55:08.297 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-22 16:55:08 +0000";
path = "/Users/Moiz/Downloads/.BAH.vJUJv";
shouldDoFullScan = 0;
},
{
date = "2019-03-22 16:55:08 +0000";
path = "/Users/Moiz/Downloads/1234and5thelanchestersepccerts";
shouldDoFullScan = 0;
},
{
date = "2019-03-22 16:55:08 +0000";
path = "/Users/Moiz/Downloads/.DS_Store";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-22 16:55:08.297 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/.BAH.vJUJv:, No such file or directory
2019-03-22 16:55:08.297 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-22 16:55:08.297 HazelHelper[363] DEBUG: Task already running for folder: /Users/Moiz/Downloads
2019-03-22 16:55:08.428 hazelworker[33552] DEBUG: Processing directories: (
"/Users/Moiz/Downloads"
)
2019-03-22 16:55:08.431 HazelHelper[363] DEBUG: Checking events for path /Users/Moiz/Downloads, folder Downloads
2019-03-22 16:55:08.432 hazelworker[33552] DEBUG: Received file event: {
date = "2019-03-22 16:55:08 +0000";
path = "<ComNoodlesoft_NoodlePathSet: 0x7fb809420810>\n /Users/Moiz/Downloads/.com.google.Chrome.k0YOki : 0\n /Users/Moiz/Downloads/Unconfirmed 785859.crdownload : 0\n /Users/Moiz/Downloads/.BAH.vJUJv : 0\n /Users/Moiz/Downloads/1234and5thelanchestersepccerts : 0\n /Users/Moiz/Downloads/.DS_Store : 0\n /Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip : 0\n";
}
2019-03-22 16:55:08.432 hazelworker[33552] DEBUG: About to process directory /Users/Moiz/Downloads
2019-03-22 16:55:08.433 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/btasmu01.pdf. File/folder not part of change set/file event.
2019-03-22 16:55:08.434 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/Ashara 1441h - 010219_v3.pptx. File/folder not part of change set/file event.
2019-03-22 16:55:08.434 hazelworker[33552] File .DS_Store is busy. Skipping for now.
2019-03-22 16:55:08.434 hazelworker[33552] DEBUG: Tapping busy retry sequence.
2019-03-22 16:55:08.435 hazelworker[33552] DEBUG: .localized: File is hidden/invisible. Skipping.
2019-03-22 16:55:08.435 hazelworker[33552] DEBUG: Found BSD advisory lock for file: /Users/Moiz/Downloads/~$Ashara 1441h - 010219_v4.pptx
2019-03-22 16:55:08.435 hazelworker[33552] File ~$Ashara 1441h - 010219_v4.pptx is busy. Skipping for now.
2019-03-22 16:55:08.435 hazelworker[33552] DEBUG: Tapping busy retry sequence.
2019-03-22 16:55:08.435 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/Ashara 1441h - 010219_v4.pptx. File/folder not part of change set/file event.
2019-03-22 16:55:08.436 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/haloupdateandpartcosting. File/folder not part of change set/file event.
2019-03-22 16:55:08.436 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/164ladbrokeroadcheckin. File/folder not part of change set/file event.
2019-03-22 16:55:08.436 hazelworker[33552] DEBUG: ~$entManagementPlan.doc: File is hidden/invisible. Skipping.
2019-03-22 16:55:08.437 hazelworker[33552] DEBUG: .com.google.Chrome.BU04fP: File is hidden/invisible. Skipping.
2019-03-22 16:55:08.437 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/haloupdateandpartcosting-1. File/folder not part of change set/file event.
2019-03-22 16:55:08.437 hazelworker[33552] File 1234and5thelanchestersepccerts.zip is busy. Skipping for now.
2019-03-22 16:55:08.437 hazelworker[33552] DEBUG: Tapping busy retry sequence.
2019-03-22 16:55:08.437 hazelworker[33552] DEBUG: Skipped /Users/Moiz/Downloads/fwdasharamubaraka. File/folder not part of change set/file event.
2019-03-22 16:55:08.438 hazelworker[33552] File 1234and5thelanchestersepccerts is busy. Skipping for now.
2019-03-22 16:55:08.438 hazelworker[33552] DEBUG: Tapping busy retry sequence.
2019-03-22 16:55:08.438 hazelworker[33552] DEBUG: ~$hara 1441h_190219.docx: File is hidden/invisible. Skipping.
2019-03-22 16:55:08.439 hazelworker[33552] DEBUG: Writing out DB file for /Users/Moiz/Downloads to path: /Users/Moiz/Library/Application Support/Hazel/16777219-603829.hazeldb
2019-03-22 16:55:08.440 hazelworker[33552] DEBUG: Directory /Users/Moiz/Downloads processed in 0.008604 seconds
2019-03-22 16:55:08.441 HazelHelper[363] DEBUG: Checking events for path /Users/Moiz/Downloads, folder Downloads
2019-03-22 16:55:08.441 hazelworker[33552] DEBUG: Sleeping
2019-03-22 16:55:10.452 hazelworker[33552] DEBUG: Could not get modfication date of Safari prefs file /Users/Moiz/Library/Preferences/com.apple.Safari.plist: Error Domain=NSCocoaErrorDomain Code=260 "The file “com.apple.Safari.plist” couldn’t be opened because there is no such file." UserInfo={NSURL=file:///Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSFilePath=/Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSUnderlyingError=0x7fb809634120 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-22 16:55:10.452 hazelworker[33552] DEBUG: Could not get modfication date of Safari prefs file /Users/Moiz/Library/Preferences/com.apple.Safari.plist: Error Domain=NSCocoaErrorDomain Code=260 "The file “com.apple.Safari.plist” couldn’t be opened because there is no such file." UserInfo={NSURL=file:///Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSFilePath=/Users/Moiz/Library/Preferences/com.apple.Safari.plist, NSUnderlyingError=0x7fb80964b050 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2019-03-22 16:55:10.453 hazelworker[33552] DEBUG: About to process directory /Users/Moiz/Downloads
2019-03-22 16:55:10.503 hazelworker[33552] DEBUG: btasmu01.pdf: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.503 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/btasmu01.pdf: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.506 hazelworker[33552] DEBUG: Ashara 1441h - 010219_v3.pptx: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.506 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/Ashara 1441h - 010219_v3.pptx: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.507 hazelworker[33552] DEBUG: .DS_Store: File is hidden/invisible. Skipping.
2019-03-22 16:55:10.507 hazelworker[33552] DEBUG: .localized: File is hidden/invisible. Skipping.
2019-03-22 16:55:10.507 hazelworker[33552] DEBUG: Found BSD advisory lock for file: /Users/Moiz/Downloads/~$Ashara 1441h - 010219_v4.pptx
2019-03-22 16:55:10.507 hazelworker[33552] File ~$Ashara 1441h - 010219_v4.pptx is busy. Skipping for now.
2019-03-22 16:55:10.507 hazelworker[33552] DEBUG: Tapping busy retry sequence.
2019-03-22 16:55:10.509 hazelworker[33552] DEBUG: Ashara 1441h - 010219_v4.pptx: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.509 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/Ashara 1441h - 010219_v4.pptx: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.512 hazelworker[33552] DEBUG: haloupdateandpartcosting: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.512 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/haloupdateandpartcosting: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.517 hazelworker[33552] DEBUG: 164ladbrokeroadcheckin: Rule signature matched for rule 3 Days Old. Not executing actions.
2019-03-22 16:55:10.517 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/164ladbrokeroadcheckin: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.518 hazelworker[33552] DEBUG: ~$entManagementPlan.doc: File is hidden/invisible. Skipping.
2019-03-22 16:55:10.519 hazelworker[33552] DEBUG: .com.google.Chrome.BU04fP: File is hidden/invisible. Skipping.
2019-03-22 16:55:10.520 hazelworker[33552] DEBUG: Original names: (
haloupdateandpartcosting
)
2019-03-22 16:55:10.520 hazelworker[33552] DEBUG: Candidate dupe: haloupdateandpartcosting-1 extension:
2019-03-22 16:55:10.520 hazelworker[33552] DEBUG: Candidate dupe found: haloupdateandpartcosting for file: haloupdateandpartcosting-1
2019-03-22 16:55:10.520 hazelworker[33552] DEBUG: File was previously diffed and file has not changed. No diff check needed.
2019-03-22 16:55:10.522 hazelworker[33552] DEBUG: haloupdateandpartcosting-1: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.522 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/haloupdateandpartcosting-1: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.530 hazelworker[33552] 1234and5thelanchestersepccerts.zip: Rule Unarchive and Delete matched.
2019-03-22 16:55:10.531 hazelworker[33552] DEBUG: New rule signature. Executing actions.
Old signatures: (
)
New Signature:{typeObject isType: "public.archive"}:{(unarchive:,{
})}
2019-03-22 16:55:10.588 hazelworker[33552] [File Event] File unarchived: /Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip unarchived to /Users/Moiz/Downloads/1234and5thelanchestersepccerts-1.
2019-03-22 16:55:10.588 hazelworker[33552] DEBUG: Rule executed. Updating match date for file /Users/Moiz/Downloads/1234and5thelanchestersepccerts-1: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.588 hazelworker[33552] DEBUG: Action changed file: 1234and5thelanchestersepccerts-1
2019-03-22 16:55:10.606 hazelworker[33552] DEBUG: fwdasharamubaraka: Rule signature matched for rule Today - Red. Not executing actions.
2019-03-22 16:55:10.606 hazelworker[33552] DEBUG: Updating match date for file /Users/Moiz/Downloads/fwdasharamubaraka: 2019-03-22 16:55:10 +0000
2019-03-22 16:55:10.609 hazelworker[33552] 1234and5thelanchestersepccerts: Rule Today - Red matched.
2019-03-22 16:55:10.609 hazelworker[33552] DEBUG: New rule signature. Executing actions.
Old signatures: (
)
New Signature:{dateCreated ==[cd] today}:{(color:1,{
})}
2019-03-22 16:55:10.631 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-22 16:55:10 +0000";
path = "/Users/Moiz/Downloads/1234and5thelanchestersepccerts-1";
shouldDoFullScan = 0;
},
{
date = "2019-03-22 16:55:10 +0000";
path = "/Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/Downloads
2019-03-22 16:55:10.631 HazelHelper[363] DEBUG: Error resolving symlinks for path /Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip:, No such file or directory
2019-03-22 16:55:10.631 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/Downloads
2019-03-22 16:55:10.632 HazelHelper[363] DEBUG: Task already running for folder: /Users/Moiz/Downloads
2019-03-22 16:55:11.595 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Received events (
{
date = "2019-03-22 16:55:11 +0000";
path = "/Users/Moiz/.Trash/1234and5thelanchestersepccerts.zip";
shouldDoFullScan = 0;
}
) for stream at path: /Users/Moiz/.Trash
2019-03-22 16:55:11.595 HazelHelper[363] DEBUG: Thread 0x6000013cd700: Run worker for folder: /Users/Moiz/.Trash
2019-03-22 16:55:11.648 hazelworker[33570] Running worker (v4.3.4) for folder with identifier: trash.
2019-03-22 16:55:11.651 hazelworker[33570] ###main load address: 0x10d7e8000

This time I downloaded a zip file from Gmail but have not paused any of the other actions. I captured the log data immediately after the zip file processed and unarchived.
makmanuk
 
Posts: 7
Joined: Tue Mar 12, 2019 6:08 am

Re: Unarchive not deleting first time Mon Mar 25, 2019 11:00 am • by Mr_Noodle
I see this:

2019-03-22 16:55:10.588 hazelworker[33552] [File Event] File unarchived: /Users/Moiz/Downloads/1234and5thelanchestersepccerts.zip unarchived to /Users/Moiz/Downloads/1234and5thelanchestersepccerts-1.

Does "1234and5thelanchestersepccerts" already exist? I don't see a record of where that is coming from.

Maybe it's better if you email in to support at this point. I suggest doing the following:

- Clean out everything in the folder so it is clear there are no existing files that may conflict.
- In the logs, mark that point.
- Add the zip file and wait until it unpacks it.
- Send the full logs from the point you marked earlier.
Mr_Noodle
Site Admin
 
Posts: 7810
Joined: Sun Sep 03, 2006 1:30 am
Location: New York City


Return to Support