The Community Forums

Interact with an entire community of cPanel & WHM users!
  1. This site uses cookies. By continuing to use this site, you are agreeing to our use of cookies. Learn More.

UPCP Won't Run, Says Another Process Running (It's Not)

Discussion in 'General Discussion' started by mdvaldosta, Sep 28, 2016.

  1. mdvaldosta

    mdvaldosta Registered

    Joined:
    Jul 14, 2016
    Messages:
    3
    Likes Received:
    0
    Trophy Points:
    1
    Location:
    Valdosta, GA
    cPanel Access Level:
    Root Administrator
    So I've got a weird issue. I'm working on a client's box and noticed their on WHM 11.50, but they're set to auto-update. So I click the upgrade link from WHM and get the "There is another upcp process running, and you are watching the log from the existing process." message. Yet the log output shows complete and a date of 2015.

    Code:
    The upcp process cannot be found. This will be the output from the last run.
    ----------------------------------------------------------------------------------------------------
    => Log opened from cPanel Update (upcp) - Slave (17636) at Wed Jun 17 13:58:01 2015
    [2015-06-17 13:58:01 -0400] Detected cron=1 (cron mode set from command line)
    [2015-06-17 13:58:01 -0400] Running Standardized hooks
    [2015-06-17 13:58:01 -0400] mtime on upcp is 1434478252 (Tue Jun 16 14:10:52 2015)
    ----------------------------------------------------------------------------------------------------
    => Log opened from /usr/local/cpanel/scripts/updatenow (17638) at Wed Jun 17 13:58:03 2015
    [2015-06-17 13:58:03 -0400] Detected version '11.50.0.10' from version file.
    [2015-06-17 13:58:03 -0400] Running version '11.50.0.10' of updatenow.
    [2015-06-17 13:58:03 -0400] Using mirror '206.130.99.76' for host 'httpupdate.cpanel.net'.
    [2015-06-17 13:58:03 -0400] Target version set to '11.50.0.10'
    [2015-06-17 13:58:03 -0400] Up to date (11.50.0.10)
    [2015-06-17 13:58:03 -0400] E The install encountered a fatal error: Up to date (11.50.0.10)
    => Log closed Wed Jun 17 13:58:03 2015
    => Log closed Wed Jun 17 13:58:03 2015
    ----------------------------------------------------------------------------------------------------
    => Log opened from /usr/local/cpanel/scripts/maintenance (17650) at Wed Jun 17 13:58:03 2015
    [2015-06-17 13:58:03 -0400] Purging cpupdate.conf of invalid entries
    [2015-06-17 13:58:03 -0400] Processing: Assuring needed symlinks in 3rdparty/bin are in place.
    [2015-06-17 13:58:03 -0400] - Processing command `/usr/local/cpanel/scripts/link_3rdparty_binaries`
    [2015-06-17 13:58:03 -0400] Processing: Setting clock
    [2015-06-17 13:58:03 -0400] - Processing command `/usr/local/cpanel/scripts/rdate`
    [2015-06-17 13:58:03 -0400] [17652] The 'ntpd' daemon is running on PID '921'. Exiting.
    [2015-06-17 13:58:03 -0400] Processing: Checking for immutable files
    [2015-06-17 13:58:03 -0400] - Processing command `/usr/local/cpanel/scripts/check_immutable_files`
    [2015-06-17 13:58:03 -0400] [17653] Not testing for immutable files, because the test was last run approximately 9 days ago (less than 10 days)
    [2015-06-17 13:58:04 -0400] Processing: Checking CloudLinux installation
    [2015-06-17 13:58:04 -0400] - Processing command `/usr/local/cpanel/bin/cloudlinux_update`
    [2015-06-17 13:58:05 -0400] Processing: Checking for a broken /usr/bin/perl pathtools in RHEL 5
    [2015-06-17 13:58:05 -0400] - Processing command `/usr/local/cpanel/scripts/redhat5_pathtools_fixer`
    [2015-06-17 13:58:05 -0400] Processing: Updating system packages
    [2015-06-17 13:58:05 -0400] - Processing command `/usr/local/cpanel/scripts/rpmup`
    [2015-06-17 13:58:06 -0400] [17668] checkyum version 22.3
    [2015-06-17 13:58:18 -0400] [17668] Loaded plugins: fastestmirror, security
    [2015-06-17 13:58:18 -0400] [17668] Setting up Update Process
    [2015-06-17 13:58:18 -0400] [17668] Loading mirror speeds from cached hostfile
    [2015-06-17 13:58:18 -0400] [17668] No Packages marked for Update
    [2015-06-17 13:58:30 -0400] [17668] checkyum version 22.3
    [2015-06-17 13:58:30 -0400] - Processing command `/usr/local/cpanel/scripts/sysup`
    [2015-06-17 13:58:35 -0400] [19054] All Needed RPMS are installed.
    [2015-06-17 13:58:35 -0400] Processing: Running platform specific optimizations
    [2015-06-17 13:58:35 -0400] - Processing command `/usr/local/cpanel/scripts/vps_optimizer`
    [2015-06-17 13:58:36 -0400] Processing: Checking for a valid C Compiler.
    [2015-06-17 13:58:36 -0400] - Processing command `/usr/local/cpanel/scripts/checkccompiler`
    [2015-06-17 13:58:36 -0400] [19059] C compiler (/usr/bin/gcc) OK (cached Tue Jun 16 14:26:46 2015)
    [2015-06-17 13:58:36 -0400] [19059] Tuned C compiler not available because it is not enabled
    [2015-06-17 13:58:36 -0400] Processing: Ensuring locale databases are up to date
    [2015-06-17 13:58:36 -0400] - Processing command `/usr/local/cpanel/bin/build_locale_databases --quiet`
    [2015-06-17 13:58:59 -0400] Processing: Migrating feature lists to current version (if needed)
    [2015-06-17 13:58:59 -0400] - Processing command `/usr/local/cpanel/bin/migrate_all_feature_lists_to_current`
    [2015-06-17 13:58:59 -0400] [19235] Migrated 0 feature list(s)
    [2015-06-17 13:58:59 -0400] Processing: Checking for main IP changes
    [2015-06-17 13:58:59 -0400] - Processing command `/usr/local/cpanel/scripts/mainipcheck`
    [2015-06-17 13:59:01 -0400] Processing: Validating server hostname
    [2015-06-17 13:59:01 -0400] - Processing command `/usr/local/cpanel/scripts/check_valid_server_hostname --notify`
    [2015-06-17 13:59:01 -0400] [19237] OK
    [2015-06-17 13:59:01 -0400] Processing: Validating cPanel system users
    [2015-06-17 13:59:01 -0400] - Processing command `/usr/local/cpanel/scripts/checkusers`
    [2015-06-17 13:59:01 -0400] [19239] Homedir: /var/cpanel/userhomes/cpanel
    [2015-06-17 13:59:01 -0400] Processing: Making sure /var/cpanel/sysinfo.conf is present
    [2015-06-17 13:59:01 -0400] - Processing command `/usr/local/cpanel/scripts/gensysinfo`
    [2015-06-17 13:59:01 -0400] Processing: Checking and repairing nameserver config
    [2015-06-17 13:59:01 -0400] - Processing command `/usr/local/cpanel/scripts/fixrndc`
    [2015-06-17 13:59:03 -0400] Processing: Setting up IP aliases startup
    [2015-06-17 13:59:03 -0400] - Processing command `/usr/local/cpanel/whostmgr/bin/setupipaliases`
    [2015-06-17 13:59:03 -0400] [19255] The installation succeeded.
    [2015-06-17 13:59:03 -0400] [19255] enable was successful
    [2015-06-17 13:59:03 -0400] - Processing command `/usr/local/cpanel/scripts/cpservice ipaliases enable 35`
    [2015-06-17 13:59:04 -0400] [19264] enable was successful
    [2015-06-17 13:59:04 -0400] Processing: Checking on RPM database
    [2015-06-17 13:59:04 -0400] - Processing command `/scripts/find_and_fix_rpm_issues`
    [2015-06-17 13:59:04 -0400] [19270] Checking that the RPM DB is OK...
    [2015-06-17 13:59:04 -0400] [19270] glibc-2.12-1.149.el6_6.9.x86_64
    [2015-06-17 13:59:04 -0400] [19270] glibc-2.12-1.149.el6_6.9.i686
    [2015-06-17 13:59:04 -0400] [19270] OK: RPM DB is responding to queries
    [2015-06-17 13:59:04 -0400] [19270] Testing if rpm_is_working RPM is installed
    [2015-06-17 13:59:04 -0400] [19270] package rpm_is_working is not installed
    [2015-06-17 13:59:04 -0400] [19270] Testing if it's possible to install a simple RPM
    [2015-06-17 13:59:05 -0400] [19270] Preparing... ##################################################
    [2015-06-17 13:59:05 -0400] [19270] rpm_is_working ##################################################
    [2015-06-17 13:59:06 -0400] Processing: Checking cPanel RPMs
    [2015-06-17 13:59:06 -0400] - Processing command `/usr/local/cpanel/scripts/check_cpanel_rpms --list-only --long-list --notify`
    [2015-06-17 14:00:37 -0400] Processing: Running env auto repair
    [2015-06-17 14:00:37 -0400] - Processing command `/usr/local/cpanel/scripts/vzzo-fixer`
    [2015-06-17 14:00:37 -0400] - Processing command `/usr/local/cpanel/scripts/quota_auto_fix`
    [2015-06-17 14:00:37 -0400] [20062] quota test: check passed
    [2015-06-17 14:00:37 -0400] - Processing command `/usr/local/cpanel/scripts/clear_orphaned_virtfs_mounts --inactiveonly`
    [2015-06-17 14:00:38 -0400] Processing: Cleaning up orphaned filesystem quotas
    [2015-06-17 14:00:38 -0400] - Processing command `/usr/local/cpanel/scripts/cleanquotas`
    [2015-06-17 14:00:38 -0400] - Processing command `/usr/local/cpanel/scripts/autorepair autorepair`
    [2015-06-17 14:00:38 -0400] [20068] Requesting script ... Done
    [2015-06-17 14:00:38 -0400] [20068] Auto Repair is running...Running Auto Repair routines
    [2015-06-17 14:00:38 -0400] [20068] Finished running Auto Repair routines
    [2015-06-17 14:00:38 -0400] [20068] ...Auto Repair is done.
    [2015-06-17 14:00:38 -0400] - Processing command `/usr/local/cpanel/scripts/cleanupcheck`
    [2015-06-17 14:00:38 -0400] - Processing command `/usr/local/cpanel/scripts/purge_old_config_caches`
    [2015-06-17 14:00:39 -0400] - Processing command `/usr/local/cpanel/scripts/cleansessions`
    [2015-06-17 14:00:39 -0400] - Processing command `/usr/local/cpanel/scripts/checkbashshell`
    [2015-06-17 14:00:39 -0400] - Processing command `/usr/local/cpanel/scripts/purge_modsec_log`
    [2015-06-17 14:00:39 -0400] Processing: Rebuilding sprites
    [2015-06-17 14:00:39 -0400] - Processing command `/usr/local/cpanel/bin/sprite_generator --all`
    [2015-06-17 14:00:44 -0400] [20076] *** Rebuilding sprites for x3 ***
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding ([root]) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/sundaymorning (sundaymorning) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/the_beach (the_beach) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/crimson_smoke (crimson_smoke) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/falltheme (falltheme) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/monsoon (monsoon) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....No Images found!
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/black_ice (black_ice) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/business2business (business2business) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/clocks (clocks) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/servers (servers) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:44 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/tealmadness (tealmadness) -=-
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:44 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/x (x) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....96....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....96....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/mobile (mobile) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....93....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....93....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/blue_lagoon (blue_lagoon) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....No Images found!
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3/branding/motor_city (motor_city) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....95....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:46 -0400] [20076] *** Done rebuilding sprites for x3 ***
    [2015-06-17 14:00:46 -0400] [20076] 
    [2015-06-17 14:00:46 -0400] [20076] 
    [2015-06-17 14:00:46 -0400] [20076] *** Rebuilding sprites for x3mail ***
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding ([root]) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/sundaymorning (sundaymorning) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/the_beach (the_beach) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/crimson_smoke (crimson_smoke) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/falltheme (falltheme) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:46 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/black_ice (black_ice) -=-
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:46 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/business2business (business2business) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/clocks (clocks) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/servers (servers) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/tealmadness (tealmadness) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/x (x) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....33....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....33....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/mobile (mobile) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....31....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....31....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/blue_lagoon (blue_lagoon) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....No Images found!
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/x3mail/branding/motor_city (motor_city) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....32....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....10....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....8....Done
    [2015-06-17 14:00:49 -0400] [20076] *** Done rebuilding sprites for x3mail ***
    [2015-06-17 14:00:49 -0400] [20076] 
    [2015-06-17 14:00:49 -0400] [20076] 
    [2015-06-17 14:00:49 -0400] [20076] *** Rebuilding sprites for hostmonster ***
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding ([root]) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:49 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/sundaymorning (sundaymorning) -=-
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:49 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/the_beach (the_beach) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/crimson_smoke (crimson_smoke) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/falltheme (falltheme) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/monsoon (monsoon) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....No Images found!
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/black_ice (black_ice) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/business2business (business2business) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/clocks (clocks) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/servers (servers) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/tealmadness (tealmadness) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/x (x) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/mobile (mobile) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....23....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....23....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/blue_lagoon (blue_lagoon) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....No Images found!
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] -=- Processing Branding Dir: /usr/local/cpanel/base/frontend/hostmonster/branding/motor_city (motor_city) -=-
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: method=scale_60percent,format=png,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: format=jpg,compression=95,imgtype=icon,subtype=img....19....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=bg,method=snap_to_smallest_width,format=png....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=compleximg....1....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: imgtype=heading,subtype=img,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=bg,imgtype=ui,method=snap_to_smallest_width,format=png....6....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,format=png....12....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=skip_filetype_gif,format=jpg,compression=95....2....Done
    [2015-06-17 14:00:51 -0400] [20076]  Sprite: subtype=img,imgtype=ui,method=only_filetype_gif,format=gif....10....Done
    [2015-06-17 14:00:51 -0400] [20076] *** Done rebuilding sprites for hostmonster ***
    [2015-06-17 14:00:51 -0400] [20076] 
    [2015-06-17 14:00:51 -0400] [20076] 
    [2015-06-17 14:00:59 -0400] Setting up cronjobs
    [2015-06-17 14:00:59 -0400] Setting Up update_db_cache Crontab
    [2015-06-17 14:00:59 -0400] Setting Up update_maiman_cache Crontab
    [2015-06-17 14:00:59 -0400] Setting Up dcpumon Crontab
    [2015-06-17 14:00:59 -0400] - Processing command `/usr/local/cpanel/scripts/dnsqueuecron`
    [2015-06-17 14:00:59 -0400] Processing: Updating services and databases
    [2015-06-17 14:00:59 -0400] - Processing command `/usr/local/cpanel/scripts/findphpversion`
    [2015-06-17 14:01:00 -0400] [20098] PHP version file is up to date
    [2015-06-17 14:01:00 -0400] - Processing command `/usr/local/cpanel/scripts/checkerrorlogsafe`
    [2015-06-17 14:01:00 -0400] - Processing command `/usr/local/cpanel/scripts/listcheck`
    [2015-06-17 14:01:00 -0400] - Processing command `/usr/local/cpanel/scripts/ftpquotacheck`
    [2015-06-17 14:01:00 -0400] [20101] Ftp Quota Check v1.8
    [2015-06-17 14:01:00 -0400] [20101] [ftpquotacheck] Setting I/O priority to reduce system load: best-effort: prio 6
    [2015-06-17 14:01:00 -0400] [20101] Updating thinkpa1: ...Done
    [2015-06-17 14:01:00 -0400] - Processing command `/usr/local/cpanel/scripts/updateuserdomains`
    [2015-06-17 14:01:00 -0400] - Processing command `/usr/local/cpanel/scripts/build_maxemails_config`
    [2015-06-17 14:01:01 -0400] - Processing command `/usr/local/cpanel/scripts/updateuserdatacache --force`
    [2015-06-17 14:01:03 -0400] Processing: Running various cleanup scripts
    [2015-06-17 14:01:03 -0400] - Processing command `/usr/local/cpanel/scripts/resetmailmanurls`
    [2015-06-17 14:01:03 -0400] Processing: Checking MySQL to ensure we can connect
    [2015-06-17 14:01:03 -0400] - Processing command `/usr/local/cpanel/scripts/mysqlconnectioncheck`
    [2015-06-17 14:01:03 -0400] Processing: Checking PostgreSQL to ensure we can connect
    [2015-06-17 14:01:03 -0400] - Processing command `/usr/local/cpanel/bin/postgrescheck --check-auth --reset-pass-on-fail`
    [2015-06-17 14:01:04 -0400] [20122] 0
    [2015-06-17 14:01:04 -0400] - Processing command `/usr/local/cpanel/scripts/disable_unused_xinetd`
    [2015-06-17 14:01:04 -0400] Repairing Mailman Permissions
    [2015-06-17 14:01:04 -0400] - Processing command `./check_perms -f --noarchives`
    [2015-06-17 14:01:04 -0400] [20125] No problems found
    [2015-06-17 14:01:04 -0400] Processing: Running sanity checks and notifications
    [2015-06-17 14:01:04 -0400] - Processing command `/usr/local/cpanel/scripts/chkpaths`
    [2015-06-17 14:01:04 -0400] - Processing command `/usr/local/cpanel/scripts/hackcheck`
    [2015-06-17 14:01:05 -0400] - Processing command `/usr/local/cpanel/scripts/oopscheck`
    [2015-06-17 14:01:05 -0400] - Processing command `/usr/local/cpanel/scripts/fixetchosts`
    [2015-06-17 14:01:05 -0400] - Processing command `/usr/local/cpanel/scripts/quotacheck`
    [2015-06-17 14:01:05 -0400] [20131] [quotacheck] Setting I/O priority to reduce system load: best-effort: prio 6
    [2015-06-17 14:01:06 -0400] - Processing command `/usr/local/cpanel/scripts/email_archive_maintenance`
    [2015-06-17 14:01:06 -0400] - Processing command `/usr/local/cpanel/scripts/expunge_expired_transfer_sessions`
    [2015-06-17 14:01:06 -0400] - Processing command `/usr/local/cpanel/scripts/smartcheck`
    [2015-06-17 14:01:06 -0400] - Processing command `/usr/local/cpanel/scripts/compilerscheck`
    [2015-06-17 14:01:06 -0400] - Processing command `/usr/local/cpanel/scripts/updatephpconf`
    [2015-06-17 14:01:07 -0400] - Processing command `/usr/local/cpanel/scripts/check_mount_procfs`
    [2015-06-17 14:01:07 -0400] - Processing command `/usr/local/cpanel/scripts/setup_whmxfer_db`
    [2015-06-17 14:01:08 -0400] [20146] setup_whmxfer_db: database schema is up to date.
    [2015-06-17 14:01:08 -0400] - Processing command `/usr/local/cpanel/scripts/setup_modsec_db`
    [2015-06-17 14:01:08 -0400] - Processing command `/usr/local/cpanel/scripts/modsec_vendor update --auto`
    [2015-06-17 14:01:09 -0400] - Processing command `/usr/local/cpanel/bin/checkallsslcerts`
    [2015-06-17 14:01:09 -0400] Processing: Updating email whitelists
    [2015-06-17 14:01:09 -0400] - Processing command `/usr/local/cpanel/bin/rim_bis_update --quiet`
    [2015-06-17 14:01:09 -0400] Processing: Purging old comet files
    [2015-06-17 14:01:09 -0400] - Processing command `/usr/local/cpanel/bin/purge_dead_comet_files --quiet`
    [2015-06-17 14:01:09 -0400] Processing: Updating SpamAssassin rules
    [2015-06-17 14:01:09 -0400] - Processing command `/usr/local/cpanel/scripts/sa-update_wrapper`
    [2015-06-17 14:01:09 -0400] [20162] [*] Running sa-update (/usr/local/cpanel/3rdparty/perl/514/bin/sa-update).....
    [2015-06-17 14:01:09 -0400] [20162] [*] Please note that 'IO::Socket::IP' and 'Net::Patricia' are not needed by our implementation of SpamAssassin.
    [2015-06-17 14:01:09 -0400] [20162] [*] The warnings related to them can be safely ignored.
    [2015-06-17 14:01:09 -0400] [20162] 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.022 [20163] dbg: logger: adding facilities: all
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.022 [20163] dbg: logger: logging level is DBG
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.022 [20163] dbg: generic: SpamAssassin version 3.4.0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.022 [20163] dbg: generic: Perl 5.014004, PREFIX=/usr/local/cpanel/3rdparty/perl/514/lib64/perl5, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.022 [20163] dbg: config: timing enabled
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.051 [20163] dbg: config: score set 0 chosen.
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.059 [20163] dbg: generic: sa-update version svn1475932
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.059 [20163] dbg: generic: using update directory: /var/lib/spamassassin/3.004000
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.326 [20163] dbg: diag: perl platform: 5.014004 linux
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.326 [20163] dbg: diag: [...] module installed: Digest::SHA1, version 2.13
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.326 [20163] dbg: diag: [...] module installed: HTML::Parser, version 3.71
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.326 [20163] dbg: diag: [...] module installed: Net::DNS, version 0.74
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.326 [20163] dbg: diag: [...] module installed: NetAddr::IP, version 4.072
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Time::HiRes, version 1.9726
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Archive::Tar, version 1.96
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: IO::Zlib, version 1.10
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Digest::SHA1, version 2.13
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: MIME::Base64, version 3.14
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: DB_File, version 1.831
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Net::SMTP, version 2.33
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Mail::SPF, version v2.009
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Geo::IP, version 1.45
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Razor2::Client::Agent, version 2.84
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module not installed: IO::Socket::IP ('require' failed)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: IO::Socket::INET6, version 2.72
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: IO::Socket::SSL, version 1.988
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Compress::Zlib, version 2.064
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Mail::DKIM, version 0.4
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: DBI, version 1.633
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: Getopt::Long, version 2.42
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: LWP::UserAgent, version 6.05
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.327 [20163] dbg: diag: [...] module installed: HTTP::Date, version 6.02
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: diag: [...] module installed: Encode::Detect, version 1.01
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: diag: [...] module not installed: Net::Patricia ('require' failed)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: gpg: Searching for 'gpg'
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: util: current PATH is: /usr/bin:/bin:/sbin:/usr/sbin:/usr/bin:/bin:/usr/local/bin:/sbin:/usr/sbin:/usr/bin:/bin:/usr/local/bin
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: util: executable for gpg was found at /usr/bin/gpg
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: gpg: found /usr/bin/gpg
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.328 [20163] dbg: gpg: release trusted key id list: 5E541DC959CB8BAC7C78DFDC4056A61A5244EC45 0C2B1D7175B852C64B3CDC716C55397824F434CE
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.329 [20163] dbg: channel: attempting channel updates.spamassassin.org
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.329 [20163] dbg: channel: using existing directory /var/lib/spamassassin/3.004000/updates_spamassassin_org
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.330 [20163] dbg: channel: channel cf file /var/lib/spamassassin/3.004000/updates_spamassassin_org.cf
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.330 [20163] dbg: channel: channel pre file /var/lib/spamassassin/3.004000/updates_spamassassin_org.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.330 [20163] dbg: channel: metadata version = 1685512, from file /var/lib/spamassassin/3.004000/updates_spamassassin_org.cf
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.371 [20163] dbg: dns: 0.4.3.updates.spamassassin.org => 1685733, parsed as 1685733
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.371 [20163] dbg: channel: preparing temp directory for new channel
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.393 [20163] dbg: channel: created tmp directory /tmp/.spamassassin20163zsgR7etmp
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.393 [20163] dbg: generic: lint checking site pre files once before attempting channel updates
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.393 [20163] dbg: generic: SpamAssassin version 3.4.0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.394 [20163] dbg: generic: Perl 5.014004, PREFIX=/usr/local/cpanel/3rdparty/perl/514/lib64/perl5, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.394 [20163] dbg: config: timing enabled
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.395 [20163] dbg: config: score set 0 chosen.
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.397 [20163] dbg: ignore: using a test message to lint rules
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.397 [20163] dbg: config: using "/etc/mail/spamassassin" for site rules pre files
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.398 [20163] dbg: config: read file /etc/mail/spamassassin/init.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.398 [20163] dbg: config: read file /etc/mail/spamassassin/v310.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.398 [20163] dbg: config: read file /etc/mail/spamassassin/v312.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.398 [20163] dbg: config: read file /etc/mail/spamassassin/v320.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.399 [20163] dbg: config: read file /etc/mail/spamassassin/v330.pre
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.399 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp/doesnotexist" for sys rules pre files
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.399 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp/doesnotexist" for default rules dir
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.406 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp/doesnotexist/doesnotexist" for user prefs file
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.406 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.417 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.420 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.423 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.424 [20163] dbg: razor2: local tests only, skipping Razor
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.424 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.425 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.426 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.427 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.428 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.432 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.437 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.438 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.440 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Shortcircuit from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.441 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.447 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.449 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.451 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.452 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.457 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.459 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.461 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.462 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.464 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.465 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Rule2XSBody from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.467 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.468 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.471 [20163] dbg: config: finish parsing
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.471 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x335bdd0) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.471 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x36b74a8) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x3719dc8) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: replacetags: replacing tags
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: replacetags: done replacing tags
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: zoom: loading compiled ruleset from /var/lib/spamassassin/compiled/5.014/3.004000
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: FreeMail: no freemail_domains entries defined, disabling plugin
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: config: score set 0 chosen.
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.472 [20163] dbg: dns: EDNS, UDP payload size 4096
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: dns: servers obtained from Net::DNS : [74.220.195.27]:53
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: dns: nameservers set to 74.220.195.27
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: dns: using socket module: IO::Socket::INET6
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: dns: is Net::DNS::Resolver available? yes
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: dns: Net::DNS version: 0.74
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: config: time limit 300.0 s
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: message: main message type: text/plain
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: message: ---- MIME PARSER START ----
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: message: parsing normal part
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: message: storing a body to memory
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.473 [20163] dbg: message: ---- MIME PARSER END ----
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.474 [20163] dbg: check: pms new, time limit in 299.999 s
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.474 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x35625b0) implements 'check_start', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.474 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x36b74a8) implements 'check_start', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x344ae78) implements 'check_main', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: config: trusted_networks are not configured; it is recommended that you configure trusted_networks manually
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: metadata: X-Spam-Relays-Trusted: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: metadata: X-Spam-Relays-Untrusted: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: metadata: X-Spam-Relays-Internal: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: metadata: X-Spam-Relays-External: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: check: tagrun - tag RELAYSTRUSTED is now ready, value: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: check: tagrun - tag RELAYSUNTRUSTED is now ready, value: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: check: tagrun - tag RELAYSINTERNAL is now ready, value: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: check: tagrun - tag RELAYSEXTERNAL is now ready, value: 
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: check: tagrun - tag LANGUAGES is now ready, value: <UNDEF>
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.475 [20163] dbg: message: no encoding detected
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x31d8180) implements 'parsed_metadata', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Shortcircuit=HASH(0x347c380) implements 'parsed_metadata', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: dns: is DNS available? 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: check: tagrun - tag SC is now ready, value: CODE(0x373c308)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: check: tagrun - tag SCRULE is now ready, value: CODE(0x373c7a0)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: check: tagrun - tag SCTYPE is now ready, value: CODE(0x373c860)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: rules: local tests only, ignoring RBL eval
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.476 [20163] dbg: check: check_main, time limit in 299.997 s
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.477 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Shortcircuit=HASH(0x347c380) implements 'have_shortcircuited', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.477 [20163] dbg: dns: harvest_dnsbl_queries
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: check: is spam? score=0 required=5
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: check: tests=
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: check: subtests=
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: timing: total 80 ms - init: 76 (94.8%), parse: 0.66 (0.8%), extract_message_metadata: 1.44 (1.8%), get_uri_detail_list: 0.68 (0.9%)
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::MIMEHeader=HASH(0x3165910) implements 'finish_tests', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.478 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x344ae78) implements 'finish_tests', priority 0
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.479 [20163] dbg: generic: lint check of site pre files succeeded, continuing with channel updates
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.479 [20163] dbg: channel: protocol family available: inet,inet6
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.479 [20163] dbg: channel: reading MIRRORED.BY file /var/lib/spamassassin/3.004000/updates_spamassassin_org/MIRRORED.BY
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.479 [20163] dbg: channel: parsing MIRRORED.BY file for channel updates.spamassassin.org
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.479 [20163] dbg: channel: found mirror http://sa-update.dnswl.org/ weight=1
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: channel: found mirror http://www.sa-update.pccc.com/ weight=5
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: channel: found mirror http://sa-update.secnap.net/ weight=5
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: channel: found mirror http://sa-update.space-pro.be/ weight=1
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: channel: selected mirror http://www.sa-update.pccc.com
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: http: url: http://www.sa-update.pccc.com/1685733.tar.gz
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: http: downloading to: /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz, new
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: util: executable for curl was found at /usr/bin/curl
    [2015-06-17 14:01:11 -0400] [20162] Jun 17 14:01:11.480 [20163] dbg: http: /usr/bin/curl -s -L -O --remote-time -g --max-redirs 2 --connect-timeout 30 --max-time 300 --fail -o 1685733.tar.gz -- http://www.sa-update.pccc.com/1685733.tar.gz
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.255 [20163] dbg: http: process [20164], exit status: 0
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.258 [20163] dbg: http: url: http://www.sa-update.pccc.com/1685733.tar.gz.sha1
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.258 [20163] dbg: http: downloading to: /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz.sha1, new
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.258 [20163] dbg: util: executable for curl was found at /usr/bin/curl
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.258 [20163] dbg: http: /usr/bin/curl -s -L -O --remote-time -g --max-redirs 2 --connect-timeout 30 --max-time 300 --fail -o 1685733.tar.gz.sha1 -- http://www.sa-update.pccc.com/1685733.tar.gz.sha1
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.402 [20163] dbg: http: process [20165], exit status: 0
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.405 [20163] dbg: http: url: http://www.sa-update.pccc.com/1685733.tar.gz.asc
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.405 [20163] dbg: http: downloading to: /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz.asc, new
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.405 [20163] dbg: util: executable for curl was found at /usr/bin/curl
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.406 [20163] dbg: http: /usr/bin/curl -s -L -O --remote-time -g --max-redirs 2 --connect-timeout 30 --max-time 300 --fail -o 1685733.tar.gz.asc -- http://www.sa-update.pccc.com/1685733.tar.gz.asc
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.551 [20163] dbg: http: process [20166], exit status: 0
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.555 [20163] dbg: sha1: verification wanted: 59b856dec2a1302a1a5f3e4234923c4d87ccc091
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.556 [20163] dbg: sha1: verification result: 59b856dec2a1302a1a5f3e4234923c4d87ccc091
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.557 [20163] dbg: channel: populating temp content file /tmp/.spamassassin20163oD6qU2tmp
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.557 [20163] dbg: gpg: populating temp signature file
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.558 [20163] dbg: gpg: calling gpg
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.629 [20163] dbg: gpg: gpg: Signature made Tue Jun 16 22:45:57 2015 EDT using RSA key ID 24F434CE
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.630 [20163] dbg: gpg: [GNUPG:] SIG_ID oKPzi5GuzxaWfX5u4cFBX0uRlh8 2015-06-17 1434509157
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.630 [20163] dbg: gpg: [GNUPG:] GOODSIG 6C55397824F434CE updates.spamassassin.org Signing Key <release@spamassassin.org>
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.630 [20163] dbg: gpg: gpg: Good signature from "updates.spamassassin.org Signing Key <release@spamassassin.org>"
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: [GNUPG:] VALIDSIG 0C2B1D7175B852C64B3CDC716C55397824F434CE 2015-06-17 1434509157 0 4 0 1 2 00 5E541DC959CB8BAC7C78DFDC4056A61A5244EC45
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: [GNUPG:] TRUST_UNDEFINED
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: gpg: WARNING: This key is not certified with a trusted signature!
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: gpg: There is no indication that the signature belongs to the owner.
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: Primary key fingerprint: 5E54 1DC9 59CB 8BAC 7C78 DFDC 4056 A61A 5244 EC45
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: Subkey fingerprint: 0C2B 1D71 75B8 52C6 4B3C DC71 6C55 3978 24F4 34CE
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: found signature made by key 0C2B1D7175B852C64B3CDC716C55397824F434CE
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: gpg: key id 0C2B1D7175B852C64B3CDC716C55397824F434CE is release trusted
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: channel: file verification passed, testing update
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.631 [20163] dbg: channel: extracting archive
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.669 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/10_default_prefs.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.670 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/10_hasbase.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.670 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_advance_fee.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.670 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_aux_tlds.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.671 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_body_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.671 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_compensate.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.672 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_dnsbl_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.672 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_drugs.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.673 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_dynrdns.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.673 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_fake_helo_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.673 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_freemail.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.674 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_freemail_domains.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.674 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.674 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_head_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.675 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_html_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.675 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_imageinfo.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.675 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_mailspike.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.676 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_meta_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.676 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_net_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.676 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_pdfinfo.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.677 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_phrases.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.677 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_porn.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.677 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_ratware.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.678 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_uri_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.678 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/20_vbounce.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.678 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/23_bayes.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.679 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_accessdb.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.679 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_antivirus.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.679 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_asn.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.680 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_dcc.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.680 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.680 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_hashcash.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.681 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_pyzor.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.681 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_razor2.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.681 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_replace.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.682 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_spf.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.682 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_textcat.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.683 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/25_uribl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.683 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_de.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.684 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_fr.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.684 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_it.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.684 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_nl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.685 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_pl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.685 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/30_text_pt_br.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.686 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/50_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.687 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_adsp_override_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.687 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_awl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.688 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_shortcircuit.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.688 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_txrep.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.688 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_whitelist.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.689 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_whitelist_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.689 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_whitelist_spf.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.690 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/60_whitelist_subject.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.690 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/72_active.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.693 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/72_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.693 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/73_sandbox_manual_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.694 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/local.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.694 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/regression_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.695 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/sa-update-pubkey.txt
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.695 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/STATISTICS-set0-72_scores.cf.txt
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.696 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/STATISTICS-set1-72_scores.cf.txt
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.696 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/STATISTICS-set2-72_scores.cf.txt
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.696 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/STATISTICS-set3-72_scores.cf.txt
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.697 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/languages
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.697 [20163] dbg: extracting: /tmp/.spamassassin20163zsgR7etmp/user_prefs.template
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.698 [20163] dbg: generic: SpamAssassin version 3.4.0
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.699 [20163] dbg: generic: Perl 5.014004, PREFIX=/usr/local/cpanel/3rdparty/perl/514/lib64/perl5, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.699 [20163] dbg: config: timing enabled
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.699 [20163] dbg: config: score set 0 chosen.
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.701 [20163] dbg: ignore: using a test message to lint rules
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.701 [20163] dbg: config: using "/etc/mail/spamassassin" for site rules pre files
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.701 [20163] dbg: config: read file /etc/mail/spamassassin/init.pre
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.701 [20163] dbg: config: read file /etc/mail/spamassassin/v310.pre
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.701 [20163] dbg: config: read file /etc/mail/spamassassin/v312.pre
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.702 [20163] dbg: config: read file /etc/mail/spamassassin/v320.pre
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.702 [20163] dbg: config: read file /etc/mail/spamassassin/v330.pre
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.702 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp" for sys rules pre files
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.702 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp" for default rules dir
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.702 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/10_default_prefs.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/10_hasbase.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_advance_fee.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_aux_tlds.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_body_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_compensate.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_dnsbl_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_drugs.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.703 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_dynrdns.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_fake_helo_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_freemail.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_freemail_domains.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_head_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_html_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_imageinfo.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.704 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_mailspike.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_meta_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_net_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_pdfinfo.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_phrases.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_porn.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_ratware.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_uri_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/20_vbounce.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.705 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/23_bayes.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_accessdb.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_antivirus.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_asn.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_dcc.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_hashcash.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_pyzor.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.706 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_razor2.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_replace.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_spf.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_textcat.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/25_uribl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_de.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_fr.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_it.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.707 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_nl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_pl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/30_text_pt_br.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/50_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_adsp_override_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_awl.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_shortcircuit.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_txrep.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.708 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_whitelist.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.709 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_whitelist_dkim.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.709 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_whitelist_spf.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.709 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/60_whitelist_subject.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.709 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/72_active.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.709 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/72_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.710 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/73_sandbox_manual_scores.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.710 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/local.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.710 [20163] dbg: config: read file /tmp/.spamassassin20163zsgR7etmp/regression_tests.cf
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.711 [20163] dbg: config: using "/tmp/.spamassassin20163zsgR7etmp/doesnotexist" for user prefs file
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.768 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.769 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.770 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.770 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.770 [20163] dbg: razor2: local tests only, skipping Razor
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.770 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.771 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.771 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.771 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.772 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.772 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.772 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.772 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.773 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Shortcircuit from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.773 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.773 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.773 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.773 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.774 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.774 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.774 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.774 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.775 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.775 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.775 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::Rule2XSBody from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.775 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.776 [20163] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC
    [2015-06-17 14:01:12 -0400] [20162] Jun 17 14:01:12.825 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x3d37708) implements 'parse_config', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.013 [20163] dbg: config: uri_detail adding (text =~ /(?^:You may browse this\.)/) to T_AXB_URIDETAIL_BROWSETHIS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.013 [20163] dbg: config: uri_detail added T_AXB_URIDETAIL_BROWSETHIS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.100 [20163] dbg: config: warning: score set for non-existent rule PDS_FROM_2_EMAILS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.100 [20163] dbg: config: warning: score set for non-existent rule PP_TOO_MUCH_UNICODE02
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.100 [20163] dbg: config: warning: score set for non-existent rule FILL_THIS_FORM_FRAUD_PHISH
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.100 [20163] dbg: config: warning: score set for non-existent rule PP_TOO_MUCH_UNICODE05
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.100 [20163] dbg: config: warning: score set for non-existent rule PP_MIME_FAKE_ASCII_TEXT
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.101 [20163] dbg: config: warning: score set for non-existent rule FILL_THIS_FORM_LONG
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.107 [20163] dbg: config: warning: no description set for RCVD_FORGED_WROTE2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.107 [20163] dbg: config: warning: no description set for KB_RATWARE_MSGID
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.107 [20163] dbg: config: warning: no description set for FSL_FAKE_HOTMAIL_RVCD
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.108 [20163] dbg: config: warning: no description set for MIME_BOUND_EQ_REL
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.108 [20163] dbg: config: warning: no description set for FROM_MISSP_SPF_FAIL
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.108 [20163] dbg: config: warning: no description set for HELO_LH_HOME
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.109 [20163] dbg: config: warning: no description set for FAKE_REPLY_C
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.109 [20163] dbg: config: warning: no description set for MID_DEGREES
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.109 [20163] dbg: config: warning: no description set for HK_NAME_MR_MRS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.109 [20163] dbg: config: warning: no description set for L_SPAM_TOOL_13
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.110 [20163] dbg: config: warning: no description set for FSL_INTERIA_ABUSE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.110 [20163] dbg: config: warning: no description set for STOCK_PRICES
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.110 [20163] dbg: config: warning: no description set for SHORT_TERM_PRICE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.110 [20163] dbg: config: warning: no description set for STOX_AND_PRICE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.110 [20163] dbg: config: warning: no description set for LONG_TERM_PRICE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.111 [20163] dbg: config: warning: no description set for MULTIPART_ALT_NON_TEXT
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.111 [20163] dbg: config: warning: no description set for SB_GIF_AND_NO_URIS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.111 [20163] dbg: config: warning: no description set for STOX_REPLY_TYPE_WITHOUT_QUOTES
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.111 [20163] dbg: config: warning: no description set for HIGH_CODEPAGE_URI
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.111 [20163] dbg: config: warning: no description set for TVD_SPACE_RATIO
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.112 [20163] dbg: config: warning: no description set for RCVD_IN_BRBL_LASTEXT
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.112 [20163] dbg: config: warning: no description set for FSL_HELO_BARE_IP_2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.112 [20163] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_08
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.113 [20163] dbg: config: warning: no description set for DKIM_POLICY_SIGNSOME
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.113 [20163] dbg: config: warning: no description set for HK_LOTTO
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.113 [20163] dbg: config: warning: no description set for MSGID_DOLLARS_RANDOM
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.113 [20163] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_MID
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.113 [20163] dbg: config: warning: no description set for TVD_PP_PHISH
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.114 [20163] dbg: config: warning: no description set for DKIM_POLICY_SIGNALL
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.114 [20163] dbg: config: warning: no description set for HK_SCAM_N3
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.114 [20163] dbg: config: warning: no description set for RCVD_IN_MSPIKE_ZBI
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.115 [20163] dbg: config: warning: no description set for HTTPS_HTTP_MISMATCH
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.115 [20163] dbg: config: warning: no description set for HK_NAME_FROM
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.115 [20163] dbg: config: warning: no description set for KB_FAKED_THE_BAT
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.115 [20163] dbg: config: warning: no description set for HTML_TITLE_SUBJ_DIFF
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.115 [20163] dbg: config: warning: no description set for DKIM_POLICY_TESTING
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.116 [20163] dbg: config: warning: no description set for CTYPE_001C_B
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.116 [20163] dbg: config: warning: no description set for HELO_LH_LD
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.116 [20163] dbg: config: warning: no description set for BASE64_LENGTH_78_79
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.116 [20163] dbg: config: warning: no description set for FSL_HELO_DEVICE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.117 [20163] dbg: config: warning: no description set for DOS_STOCK_BAT2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.117 [20163] dbg: config: warning: no description set for TVD_SPACE_ENCODED
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.117 [20163] dbg: config: warning: no description set for TVD_RCVD_SPACE_BRACKET
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.117 [20163] dbg: config: warning: no description set for GEO_QUERY_STRING
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.118 [20163] dbg: config: warning: no description set for THEBAT_UNREG
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.118 [20163] dbg: config: warning: no description set for FSL_HELO_BARE_IP_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.119 [20163] dbg: config: warning: no description set for HELO_OEM
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.119 [20163] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_16
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.119 [20163] dbg: config: warning: no description set for X_MAILER_CME_6543_MSN
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.119 [20163] dbg: config: warning: no description set for CTYPE_001C_A
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.120 [20163] dbg: config: warning: no description set for LOTTERY_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.120 [20163] dbg: config: warning: no description set for KB_DATE_CONTAINS_TAB
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.120 [20163] dbg: config: warning: no description set for DKIM_VERIFIED
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.120 [20163] dbg: config: warning: no description set for FSL_HELO_SETUP
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.120 [20163] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_12
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.121 [20163] dbg: config: warning: no description set for HK_SCAM_N2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.121 [20163] dbg: config: warning: no description set for HELO_LOCALHOST
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.121 [20163] dbg: config: warning: no description set for KB_RATWARE_BOUNDARY
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.121 [20163] dbg: config: warning: no description set for JM_I_FEEL_LUCKY
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.122 [20163] dbg: config: warning: no description set for JM_TORA_XM
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.122 [20163] dbg: config: warning: no description set for TVD_SPACE_RATIO_MINFP
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.123 [20163] dbg: config: warning: no description set for JM_RCVD_QMAILV1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.123 [20163] dbg: config: warning: no description set for STOX_REPLY_TYPE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.123 [20163] dbg: config: warning: no description set for FSL_HELO_NON_FQDN_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.123 [20163] dbg: config: warning: no description set for TVD_EB_PHISH
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.124 [20163] dbg: config: warning: no description set for BUG6152_INVALID_DATE_TZ_ABSURD
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.124 [20163] dbg: config: warning: no description set for MSOE_MID_WRONG_CASE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.124 [20163] dbg: config: warning: no description set for CURR_PRICE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.124 [20163] dbg: config: warning: no description set for LOTTERY_PH_004470
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.124 [20163] dbg: config: warning: no description set for HELO_FRIEND
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.125 [20163] dbg: config: warning: no description set for HK_SCAM_N1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.125 [20163] dbg: config: warning: no description set for TVD_FINGER_02
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.126 [20163] dbg: config: warning: no description set for REPLYTO_WITHOUT_TO_CC
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.126 [20163] dbg: config: warning: no description set for FORGED_RELAY_MUA_TO_MX
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.126 [20163] dbg: config: warning: no description set for TVD_SPACE_ENC_FM_MIME
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.127 [20163] dbg: config: warning: no description set for FSL_HELO_FIREWALL
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.127 [20163] dbg: config: warning: no description set for LIVEFILESTORE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __HAS_LIST_ID merged duplicates: __ML2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __DOS_HAS_MAILING_LIST merged duplicates: __ML4
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __JM_REACTOR_DATE merged duplicates: __RATWARE_0_TZ_DATE
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __DOS_HAS_ANY_URI merged duplicates: __HAS_ANY_URI __HAS_URI
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __HAS_REPLY_TO merged duplicates: __REPLYTO_EXISTS
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: CTYPE_001C_A merged duplicates: DATE_IN_FUTURE_96_XX
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __HAS_XMAIL merged duplicates: __HAS_X_MAILER
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: __THEBAT_MUA merged duplicates: __XM_THEBAT
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.513 [20163] dbg: rules: NAME_EMAIL_DIFF merged duplicates: __NAME_EMAIL_DIFF
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.514 [20163] dbg: config: finish parsing
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.527 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x3d32e28) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.528 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x3d37270) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.528 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x3d37708) implements 'finish_parsing_end', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.528 [20163] dbg: replacetags: replacing tags
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.539 [20163] dbg: replacetags: done replacing tags
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.539 [20163] dbg: zoom: loading compiled ruleset from /var/lib/spamassassin/compiled/5.014/3.004000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.555 [20163] dbg: zoom: using compiled ruleset in /var/lib/spamassassin/compiled/5.014/3.004000/Mail/SpamAssassin/CompiledRegexps/body_0.pm for Mail::SpamAssassin::CompiledRegexps::body_0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.557 [20163] dbg: zoom: skipping rule __ADMITS_SPAM, code differs in compiled ruleset
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.559 [20163] dbg: zoom: able to use 346/355 'body_0' compiled rules (97.464%)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.560 [20163] dbg: FreeMail: loaded freemail_domains entries: 2532 normal, 31 wildcard
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.563 [20163] dbg: config: score set 0 chosen.
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.564 [20163] dbg: dns: EDNS, UDP payload size 4096
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.565 [20163] dbg: dns: servers obtained from Net::DNS : [74.220.195.27]:53
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.565 [20163] dbg: dns: nameservers set to 74.220.195.27
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.565 [20163] dbg: dns: using socket module: IO::Socket::INET6
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.565 [20163] dbg: dns: is Net::DNS::Resolver available? yes
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.566 [20163] dbg: dns: Net::DNS version: 0.74
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.566 [20163] dbg: config: time limit 300.0 s
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.567 [20163] dbg: message: main message type: text/plain
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.567 [20163] dbg: message: ---- MIME PARSER START ----
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.567 [20163] dbg: message: parsing normal part
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.567 [20163] dbg: message: storing a body to memory
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.567 [20163] dbg: message: ---- MIME PARSER END ----
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.568 [20163] dbg: check: pms new, time limit in 299.998 s
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.568 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x3469bd0) implements 'check_start', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.569 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x3d37270) implements 'check_start', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.570 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x3d37000) implements 'check_main', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.570 [20163] dbg: config: trusted_networks are not configured; it is recommended that you configure trusted_networks manually
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.570 [20163] dbg: metadata: X-Spam-Relays-Trusted: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: metadata: X-Spam-Relays-Untrusted: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: metadata: X-Spam-Relays-Internal: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: metadata: X-Spam-Relays-External: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: check: tagrun - tag RELAYSTRUSTED is now ready, value: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: check: tagrun - tag RELAYSUNTRUSTED is now ready, value: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: check: tagrun - tag RELAYSINTERNAL is now ready, value: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: check: tagrun - tag RELAYSEXTERNAL is now ready, value: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: check: tagrun - tag LANGUAGES is now ready, value: <UNDEF>
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.571 [20163] dbg: message: no encoding detected
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x3d32528) implements 'parsed_metadata', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Shortcircuit=HASH(0x3d370d8) implements 'parsed_metadata', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: check: tagrun - tag SC is now ready, value: CODE(0x3ddf7b0)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: check: tagrun - tag SCRULE is now ready, value: CODE(0x3f45130)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: check: tagrun - tag SCTYPE is now ready, value: CODE(0x3edc1f0)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: rules: local tests only, ignoring RBL eval
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.572 [20163] dbg: check: check_main, time limit in 299.994 s
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.573 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Shortcircuit=HASH(0x3d370d8) implements 'have_shortcircuited', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.573 [20163] dbg: check: running tests for priority: -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.573 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x3d37270) implements 'check_rules_at_priority', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.573 [20163] dbg: rules: running one_line_body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.574 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 524 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.574 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.574 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.574 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x3d37270) implements 'run_body_fast_scan', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: running head tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 304 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: running head_eval tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.575 [20163] dbg: rules: run_eval_tests - compiling eval code: 9, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.576 [20163] dbg: eval: all '*From' addrs: ignore@compiling.spamassassin.taint.org
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.577 [20163] dbg: eval: all '*To' addrs: 
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.577 [20163] dbg: rules: running body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.577 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 247 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: running uri tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.578 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: running rawbody tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 253 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: running full tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 282 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.579 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.580 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.580 [20163] dbg: rules: running meta tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.580 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 307 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg1000_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.580 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority -1000
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.580 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: check: running tests for priority: -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: rules: running one_line_body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 521 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.581 [20163] dbg: rules: running head tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.582 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 302 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.582 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.582 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.582 [20163] dbg: rules: running head_eval tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.582 [20163] dbg: rules: run_eval_tests - compiling eval code: 9, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: running body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: running uri tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.583 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: running rawbody tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 251 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.584 [20163] dbg: rules: running full tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: running meta tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 305 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg950_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.585 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority -950
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: check: running tests for priority: -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: rules: running one_line_body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 521 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.586 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.587 [20163] dbg: rules: running head tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.587 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 302 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.587 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.587 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.587 [20163] dbg: rules: running head_eval tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.588 [20163] dbg: rules: run_eval_tests - compiling eval code: 9, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.588 [20163] dbg: rules: running body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.588 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: running uri tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.589 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: running rawbody tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 251 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: running full tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.590 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: running meta tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 305 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg900_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority -900
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.591 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: check: running tests for priority: -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: running one_line_body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 521 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: running head tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.592 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 302 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: running body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.593 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: running uri tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: running body_eval tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.594 [20163] dbg: rules: run_eval_tests - compiling eval code: 11, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: running rawbody tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 251 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: running full tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.595 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: running meta tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 305 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg400_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority -400
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.596 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.597 [20163] dbg: check: running tests for priority: 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.597 [20163] dbg: rules: running one_line_body tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.604 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 510 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_0_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.604 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.621 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.621 [20163] dbg: zoom: run_body_fast_scan for body_0 start
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.632 [20163] dbg: zoom: run_body_fast_scan for body_0 done
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.633 [20163] dbg: rules: running head tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.649 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60337 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.689 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60128 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_2
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.760 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60348 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_3
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.795 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60441 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_4
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.843 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 59958 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_5
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.873 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.873 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.874 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Shortcircuit=HASH(0x3d370d8) implements 'hit_rule', priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.874 [20163] dbg: rules: ran header rule __MISSING_REF ======> got hit: "UNSET"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.875 [20163] dbg: rules: ran header rule __MISSING_REPLY ======> got hit: "UNSET"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.875 [20163] dbg: rules: ran header rule __MSGID_OK_HOST ======> got hit: "@lint_rules>"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.875 [20163] dbg: rules: ran header rule __MSGID_OK_DIGITS ======> got hit: "1434564072"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.876 [20163] dbg: rules: ran header rule __HAS_MESSAGE_ID ======> got hit: "<YES>"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.877 [20163] dbg: rules: ran header rule __HAS_SUBJECT ======> got hit: "<YES>"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.877 [20163] dbg: rules: ran header rule __MSOE_MID_WRONG_CASE ======> got hit: "
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.877 [20163] dbg: rules: [...] Message-Id: "
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.877 [20163] dbg: rules: ran header rule __HAS_MSGID ======> got hit: "<"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.878 [20163] dbg: rules: ran header rule __SANE_MSGID ======> got hit: "<1434564072@lint_rules>
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.878 [20163] dbg: rules: [...] "
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.878 [20163] dbg: rules: ran header rule __TO_NO_ARROWS_R ======> got hit: "3.4"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.878 [20163] dbg: rules: ran header rule __HAS_FROM ======> got hit: "<YES>"
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.879 [20163] dbg: rules: running head_eval tests; score so far=0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.881 [20163] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.933 [20163] dbg: FreeMail: RULE (FREEMAIL_FROM) check_freemail_from
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.933 [20163] dbg: FreeMail: all from-addresses: ignore@compiling.spamassassin.taint.org
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.934 [20163] dbg: FreeMail: RULE (__freemail_reply) check_freemail_replyto
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.934 [20163] dbg: FreeMail: From address: ignore@compiling.spamassassin.taint.org
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.934 [20163] dbg: FreeMail: No Reply-To and From is not freemail, skipping check
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.935 [20163] dbg: rules: ran eval rule NO_RELAYS ======> got hit (1)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.936 [20163] dbg: rules: ran eval rule __GATED_THROUGH_RCVD_REMOVER ======> got hit (1)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.936 [20163] dbg: FreeMail: RULE (__smf_freemail_hdr_replyto) check_freemail_header
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.936 [20163] dbg: FreeMail: header Reply-To:addr not found from mail
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.936 [20163] dbg: FreeMail: RULE (FREEMAIL_REPLYTO_END_DIGIT) check_freemail_header regex:\d@
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.937 [20163] dbg: FreeMail: header Reply-To not found from mail
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.937 [20163] dbg: FreeMail: RULE (__freemail_replyto) check_freemail_replyto
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.937 [20163] dbg: FreeMail: From address: ignore@compiling.spamassassin.taint.org
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.937 [20163] dbg: FreeMail: Reply-To is not freemail, skipping check
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: FreeMail: RULE (__freemail_hdr_replyto) check_freemail_header
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: FreeMail: header Reply-To not found from mail
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: spf: cannot get Envelope-From, cannot use SPF
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: spf: def_spf_whitelist_from: could not find useable envelope sender
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: FreeMail: RULE (FREEMAIL_ENVFROM_END_DIGIT) check_freemail_header regex:\d@
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.938 [20163] dbg: FreeMail: header EnvelopeFrom not found from mail
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.939 [20163] dbg: spf: spf_whitelist_from: could not find useable envelope sender
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.939 [20163] dbg: rules: ran eval rule MISSING_HEADERS ======> got hit (1)
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.939 [20163] dbg: rules: running body tests; score so far=0.914
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.946 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60160 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1
    [2015-06-17 14:01:13 -0400] [20162] Jun 17 14:01:13.986 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60492 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.050 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 61703 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.083 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 13903 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.087 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.088 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.102 [20163] dbg: rules: ran body rule __NONEMPTY_BODY ======> got hit: "I"
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.119 [20163] dbg: rules: ran body rule __BODY_TEXT_LINE ======> got hit: "I"
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.135 [20163] dbg: rules: running uri tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.137 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 34894 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_0_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.160 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.161 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.161 [20163] dbg: rules: running body_eval tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.213 [20163] dbg: rules: run_eval_tests - compiling eval code: 11, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.292 [20163] dbg: https_http_mismatch: anchors 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.295 [20163] dbg: eval: body_length - 1340 - check for min of 256
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.299 [20163] dbg: eval: body_length - 1340 - check for min of 128
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.299 [20163] dbg: eval: body_length - 1340 - check for min of 1024
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.300 [20163] dbg: eval: body_length - 1340 - check for min of 512
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.312 [20163] dbg: rules: running rawbody tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.322 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 21236 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.335 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.336 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.337 [20163] dbg: rules: running rawbody_eval tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.338 [20163] dbg: rules: run_eval_tests - compiling eval code: 15, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.342 [20163] dbg: rules: running full tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.344 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 1312 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_0_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.354 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.354 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.355 [20163] dbg: rules-all: running full rule __BASE64_MDAW
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.355 [20163] dbg: rules-all: running full rule NULL_IN_BODY
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.355 [20163] dbg: rules: running full_eval tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.356 [20163] dbg: rules: run_eval_tests - compiling eval code: 13, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.357 [20163] dbg: dkim: signature verification disabled, DNS resolving not available
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.358 [20163] dbg: rules: running meta tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.358 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 297 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_0_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.359 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.359 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.360 [20163] dbg: check: running tests for priority: 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.360 [20163] dbg: dns: harvest_dnsbl_queries
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.361 [20163] dbg: rules: running one_line_body tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.361 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 516 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.362 [20163] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.362 [20163] dbg: rules: compiled one_line_body tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.363 [20163] dbg: rules: running head tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.365 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 298 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.366 [20163] dbg: rules: run_generic_tests - compiling eval code: head, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.366 [20163] dbg: rules: compiled head tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.368 [20163] dbg: rules: running body tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.368 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 241 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.368 [20163] dbg: rules: run_generic_tests - compiling eval code: body, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.369 [20163] dbg: rules: compiled body tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.369 [20163] dbg: rules: running uri tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.370 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 239 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.371 [20163] dbg: rules: run_generic_tests - compiling eval code: uri, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.371 [20163] dbg: rules: compiled uri tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.371 [20163] dbg: rules: running rawbody tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.372 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 247 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.373 [20163] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.373 [20163] dbg: rules: compiled rawbody tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.374 [20163] dbg: rules: running full tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.375 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 276 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.375 [20163] dbg: rules: run_generic_tests - compiling eval code: full, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.376 [20163] dbg: rules: compiled full tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.376 [20163] dbg: rules: running meta tests; score so far=0.914
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.378 [20163] dbg: rules: meta test DIGEST_MULTIPLE has undefined dependency 'DCC_CHECK'
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.378 [20163] dbg: rules: meta test DIGEST_MULTIPLE has undefined dependency 'PYZOR_CHECK'
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.432 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60138 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.494 [20163] dbg: rules: flush_evalstr (add_evalstr) compiling 60238 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_2
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.552 [20163] dbg: rules: flush_evalstr (run_generic_tests) compiling 43781 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_3
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.585 [20163] dbg: rules: run_generic_tests - compiling eval code: meta, priority 500
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.585 [20163] dbg: rules: compiled meta tests
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: check: is spam? score=3.652 required=5
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: check: tests=MISSING_DATE,MISSING_HEADERS,NO_RECEIVED,NO_RELAYS
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: check: subtests=__BODY_TEXT_LINE,__EMPTY_BODY,__GATED_THROUGH_RCVD_REMOVER,__HAS_FROM,__HAS_MESSAGE_ID,__HAS_MSGID,__HAS_SUBJECT,__KHOP_NO_FULL_NAME,__MISSING_REF,__MISSING_REPLY,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__MSOE_MID_WRONG_CASE,__NONEMPTY_BODY,__NOT_SPOOFED,__SANE_MSGID,__TO_NO_ARROWS_R,__UNUSABLE_MSGID
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: timing: total 1886 ms - init: 865 (45.8%), parse: 1.82 (0.1%), extract_message_metadata: 1.82 (0.1%), get_uri_detail_list: 0.69 (0.0%), tests_pri_-1000: 7 (0.4%), compile_gen: 548 (29.1%), compile_eval: 133 (7.1%), tests_pri_-950: 5 (0.3%), tests_pri_-900: 6 (0.3%), tests_pri_-400: 5 (0.3%), tests_pri_0: 763 (40.4%), tests_pri_500: 228 (12.1%)
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::MIMEHeader=HASH(0x3d32b70) implements 'finish_tests', priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.588 [20163] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x3d37000) implements 'finish_tests', priority 0
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.600 [20163] dbg: channel: lint check succeeded, extracting archive to /var/lib/spamassassin/3.004000/updates_spamassassin_org...
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.601 [20163] dbg: channel: point of no return for existing /var/lib/spamassassin/3.004000/updates_spamassassin_org
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.601 [20163] dbg: generic: cleaning directory /var/lib/spamassassin/3.004000/updates_spamassassin_org
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 20_freemail.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: preserving 1685733.tar.gz.asc
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 10_default_prefs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 23_bayes.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 20_dynrdns.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 25_razor2.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.602 [20163] dbg: generic: unlinking 25_antivirus.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 60_txrep.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 20_html_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: preserving 1685733.tar.gz
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 25_hashcash.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 30_text_fr.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: preserving 1685733.tar.gz.sha1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 20_aux_tlds.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.603 [20163] dbg: generic: unlinking 20_advance_fee.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 25_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 60_shortcircuit.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 30_text_de.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 20_compensate.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 20_ratware.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 25_textcat.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 60_awl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.604 [20163] dbg: generic: unlinking 20_drugs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking 73_sandbox_manual_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking 20_vbounce.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking 20_freemail_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking user_prefs.template
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking STATISTICS-set2-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking 20_body_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.605 [20163] dbg: generic: unlinking STATISTICS-set0-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking STATISTICS-set3-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 25_pyzor.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 25_uribl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 30_text_pt_br.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 20_porn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 50_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 25_accessdb.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.606 [20163] dbg: generic: unlinking 20_imageinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 20_fake_helo_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 72_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 30_text_nl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 25_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 20_phrases.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking STATISTICS-set1-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.607 [20163] dbg: generic: unlinking 20_meta_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking 20_uri_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking 20_head_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking 72_active.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking local.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking languages
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking 25_asn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.608 [20163] dbg: generic: unlinking 60_whitelist_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 20_dnsbl_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 20_pdfinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 10_hasbase.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 60_whitelist_subject.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 20_mailspike.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 20_net_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 60_whitelist_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.609 [20163] dbg: generic: unlinking 60_adsp_override_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.610 [20163] dbg: generic: unlinking regression_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.610 [20163] dbg: generic: unlinking 30_text_it.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.611 [20163] dbg: generic: preserving MIRRORED.BY
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.611 [20163] dbg: generic: unlinking 25_dcc.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.612 [20163] dbg: generic: unlinking 25_replace.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.612 [20163] dbg: generic: unlinking sa-update-pubkey.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.612 [20163] dbg: generic: unlinking 30_text_pl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.612 [20163] dbg: generic: unlinking 60_whitelist.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.670 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/10_default_prefs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.670 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/10_hasbase.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.671 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_advance_fee.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.671 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_aux_tlds.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.672 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_body_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.673 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_compensate.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.673 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_dnsbl_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.673 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_drugs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.674 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_dynrdns.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.675 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_fake_helo_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.679 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_freemail.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.680 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_freemail_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.685 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.685 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_head_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.686 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_html_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.687 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_imageinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.693 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_mailspike.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.694 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_meta_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.695 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_net_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.695 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_pdfinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.696 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_phrases.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.697 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_porn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.697 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_ratware.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.698 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_uri_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.699 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/20_vbounce.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.699 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/23_bayes.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.700 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_accessdb.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.701 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_antivirus.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.701 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_asn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.702 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_dcc.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.702 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.703 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_hashcash.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.704 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_pyzor.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.704 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_razor2.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.705 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_replace.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.706 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.707 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_textcat.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.708 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/25_uribl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.708 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_de.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.709 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_fr.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.711 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_it.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.711 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_nl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.712 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_pl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.713 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/30_text_pt_br.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.714 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/50_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.718 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_adsp_override_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.719 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_awl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.719 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_shortcircuit.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.720 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_txrep.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.721 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_whitelist.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.722 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_whitelist_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.723 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_whitelist_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.724 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/60_whitelist_subject.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.724 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/72_active.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.729 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/72_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.731 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/73_sandbox_manual_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.731 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/local.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.733 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/regression_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.734 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/sa-update-pubkey.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.735 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/STATISTICS-set0-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.736 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/STATISTICS-set1-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.737 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/STATISTICS-set2-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.737 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/STATISTICS-set3-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.738 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/languages
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.740 [20163] dbg: extracting: /var/lib/spamassassin/3.004000/updates_spamassassin_org/user_prefs.template
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.741 [20163] dbg: channel: creating update cf/pre files
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.745 [20163] dbg: channel: adding 10_default_prefs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.745 [20163] dbg: channel: adding 10_hasbase.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.745 [20163] dbg: channel: adding 20_advance_fee.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.745 [20163] dbg: channel: adding 20_aux_tlds.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_body_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_compensate.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_dnsbl_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_drugs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_dynrdns.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_fake_helo_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_freemail.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_freemail_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_head_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_html_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.746 [20163] dbg: channel: adding 20_imageinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_mailspike.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_meta_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_net_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_pdfinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_phrases.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_porn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_ratware.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_uri_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 20_vbounce.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 23_bayes.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 25_accessdb.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 25_antivirus.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.747 [20163] dbg: channel: adding 25_asn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_dcc.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_hashcash.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_pyzor.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_razor2.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_replace.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_textcat.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 25_uribl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 30_text_de.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 30_text_fr.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.748 [20163] dbg: channel: adding 30_text_it.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 30_text_nl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 30_text_pl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 30_text_pt_br.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 50_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_adsp_override_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_awl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_shortcircuit.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_txrep.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_whitelist.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_whitelist_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_whitelist_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 60_whitelist_subject.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.749 [20163] dbg: channel: adding 72_active.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: channel: adding 72_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: channel: adding 73_sandbox_manual_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: channel: adding local.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: channel: adding regression_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: generic: unlinking /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz.sha1
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: generic: unlinking /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz.asc
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.750 [20163] dbg: generic: unlinking /var/lib/spamassassin/3.004000/updates_spamassassin_org/1685733.tar.gz
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: channel: update complete
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: generic: cleaning up temporary directory/files
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: generic: cleaning directory /tmp/.spamassassin20163zsgR7etmp
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: generic: unlinking 20_freemail_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: generic: unlinking 25_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.751 [20163] dbg: generic: unlinking 72_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 25_hashcash.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 20_vbounce.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 20_freemail_mailcom_domains.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 20_imageinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 60_adsp_override_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 20_head_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.752 [20163] dbg: generic: unlinking 20_fake_helo_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 25_textcat.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 73_sandbox_manual_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 20_mailspike.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 10_hasbase.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 20_net_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 60_whitelist_dkim.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.753 [20163] dbg: generic: unlinking 20_freemail.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 30_text_de.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 60_whitelist.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 30_text_nl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 60_txrep.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 30_text_pt_br.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking 20_html_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.754 [20163] dbg: generic: unlinking STATISTICS-set0-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking STATISTICS-set3-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking 25_asn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking 25_replace.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking 72_active.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking languages
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.755 [20163] dbg: generic: unlinking user_prefs.template
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 20_body_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 60_whitelist_subject.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 20_compensate.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 20_ratware.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking local.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 25_antivirus.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.756 [20163] dbg: generic: unlinking 20_advance_fee.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 30_text_it.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 20_uri_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 25_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 20_porn.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 60_shortcircuit.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 25_dcc.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 25_accessdb.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.757 [20163] dbg: generic: unlinking 20_aux_tlds.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking regression_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 25_uribl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 50_scores.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking STATISTICS-set2-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 10_default_prefs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 23_bayes.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 20_dynrdns.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.758 [20163] dbg: generic: unlinking 25_pyzor.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking STATISTICS-set1-72_scores.cf.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 60_awl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 60_whitelist_spf.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 20_pdfinfo.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 30_text_fr.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 20_meta_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.759 [20163] dbg: generic: unlinking 20_drugs.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.760 [20163] dbg: generic: unlinking 30_text_pl.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.760 [20163] dbg: generic: unlinking sa-update-pubkey.txt
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.760 [20163] dbg: generic: unlinking 20_phrases.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.760 [20163] dbg: generic: unlinking 25_razor2.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.760 [20163] dbg: generic: unlinking 20_dnsbl_tests.cf
    [2015-06-17 14:01:14 -0400] [20162] Jun 17 14:01:14.761 [20163] dbg: diag: updates complete, exiting with code 0
    [2015-06-17 14:01:14 -0400] [20162] Done
    [2015-06-17 14:01:16 -0400] [20162] Checking update....update ok!
    [2015-06-17 14:01:16 -0400] Processing: Restoring compiler permissions
    [2015-06-17 14:01:16 -0400] - Processing command `/usr/local/cpanel/scripts/compilers restore`
    [2015-06-17 14:01:16 -0400] [20169] Compilers are disabled for unprivileged users.
    [2015-06-17 14:01:16 -0400] Processing: Cleaning up mailbox trash
    [2015-06-17 14:01:16 -0400] - Processing command `/usr/local/cpanel/scripts/dovecot_auto_expunge_trash`
    [2015-06-17 14:01:17 -0400] Processing: Cleaning SpamAssassin DBM files
    [2015-06-17 14:01:17 -0400] - Processing command `/usr/local/cpanel/scripts/spamassassin_dbm_cleaner`
    [2015-06-17 14:01:17 -0400] [20172] /usr/local/cpanel/scripts/spamassassin_dbm_cleaner: version 1.0
    [2015-06-17 14:01:17 -0400] [20172] Checking SpamAssassin dbm databases....Done
    [2015-06-17 14:01:17 -0400] [20172] Checked 2 files for 3 user(s), 2 ok, 0 broken
    [2015-06-17 14:01:17 -0400] Cleaning Squirrelmail attachment directories
    [2015-06-17 14:01:17 -0400] Cleaning Roundcube attachment directory
    => Log closed Wed Jun 17 14:01:17 2015
    [2015-06-17 14:01:17 -0400] Processing: Running former postinstall scripts
    [2015-06-17 14:01:17 -0400] - Processing command `/usr/local/cpanel/bin/dcpumon --killproc`
    [2015-06-17 14:01:17 -0400] [20175] Added Contact billmorrow@bellsouth.net
    [2015-06-17 14:01:17 -0400] - Processing command `/usr/local/cpanel/bin/scanfornewmail`
    [2015-06-17 14:01:17 -0400] [20180] Scanning for new mail senders.....Done
    [2015-06-17 14:01:17 -0400] - Processing command `/usr/local/cpanel/bin/setupdbmap`
    [2015-06-17 14:01:18 -0400] - Processing command `/usr/local/cpanel/bin/fix_userdata_perms`
    [2015-06-17 14:01:18 -0400] - Processing command `/usr/local/cpanel/scripts/detect_env_capabilities`
    [2015-06-17 14:01:18 -0400] - Processing command `/usr/local/cpanel/scripts/check_mysql`
    [2015-06-17 14:01:18 -0400] [20186] “check_mysql” will complete in the background (process ID 20187).
    [2015-06-17 14:01:18 -0400] 
    [2015-06-17 14:01:18 -0400] Maintenance complete.
    => Log closed Wed Jun 17 14:01:18 2015
    ----------------------------------------------------------------------------------------------------
    => Log opened from cPanel Update (upcp) - Slave (17636) at Wed Jun 17 14:01:18 2015
    [2015-06-17 14:01:18 -0400] Maintenance completed successfully
    [2015-06-17 14:01:18 -0400] Running Standardized hooks
    [2015-06-17 14:01:18 -0400] 
    [2015-06-17 14:01:18 -0400]  cPanel update completed
    [2015-06-17 14:01:18 -0400] A log of this update is available at /var/cpanel/updatelogs/update.1434563881.log
    [2015-06-17 14:01:18 -0400] Removing upcp pidfile
    [2015-06-17 14:01:18 -0400] 
    [2015-06-17 14:01:18 -0400] Completed all updates
    => Log closed Wed Jun 17 14:01:18 2015
    
    I try to run /scripts/upcp --force and it says permission denied. I checked for running a PID and of course nothing. I then issued a graceful server restart. Still can't update cPanel. What to try now?
     
  2. cPanelMichael

    cPanelMichael Forums Analyst
    Staff Member

    Joined:
    Apr 11, 2011
    Messages:
    30,811
    Likes Received:
    671
    Trophy Points:
    113
    cPanel Access Level:
    Root Administrator
    Hello,

    This suggests a potential issue with permission or ownership values on system or cPanel files. Could you open a support ticket using the link in my signature so we can take a closer look? You can post the ticket number here so we can update this thread with the outcome.

    Thank you.
     
Loading...

Share This Page