Frederick G

Q: Server 4.1 Profile Manager - Something Went Wrong

Hi,

 

I just updated my Mac Mini Server from 10.10.2 to 10.10.3, updating to Server 4.1.

 

It seemed to go okay, but now Profile Manager is messed up.  When users try to log in, they get the message:

 

We're sorry, but something went wrong.

We've been notified about this issue and we'll take a look at it shortly.

(If you're the administrator of this website, then please read the log file "profilemanager.log" to find out what went wrong.)

 

 

When I look through the logs I find this:

 

[2015/04/09 23:15:47.194] F: ActiveRecord::StatementInvalid (PG::Error: ERROR:  relation "view_all_user_groups_users_flat" does not exist

[2015/04/09 23:15:47.195] I: Rendering /Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/backend/public /500.html (500 Internal Server Error)

 

Any suggestions?

 

Thanks!

Frederick

Mac mini, OS X Yosemite (10.10.3)

Posted on Apr 9, 2015 11:22 PM

Close

Q: Server 4.1 Profile Manager - Something Went Wrong

  • All replies
  • Helpful answers

  • by mscott_mdm,

    mscott_mdm mscott_mdm Apr 10, 2015 8:38 PM in response to Frederick G
    Level 2 (225 points)
    Apr 10, 2015 8:38 PM in response to Frederick G

    Frederick,

     

    Can you look at the /Library/Logs/ProfileManager/migration_tool.log file and paste in the last 50 or so lines?

  • by Frederick G,

    Frederick G Frederick G Apr 11, 2015 12:19 AM in response to mscott_mdm
    Level 1 (0 points)
    Apr 11, 2015 12:19 AM in response to mscott_mdm

    mscott_mdm wrote:

     

    Frederick,

     

    Can you look at the /Library/Logs/ProfileManager/migration_tool.log file and paste in the last 50 or so lines?

     

    Thanks for the help!

     

    Here is the entire migration_tool.log file from updating:

     

    [20723] [2015/04/09 17:13:17.136] -[SULogFileCollection setGlobalLogLevelPrefix:]: YES

    0:: [20723] [2015/04/09 17:13:17.138]

        ############################################################################### ####

        migration_tool-886.204 (PID:20723, OS:14D131, SERVER:14S1092, ARCH:x86_64) starting

        LA: migration_tool

        ############################################################################### ####

    0:: [20723] [2015/04/09 17:13:17.203] Waiting for postgres to startup....

    0:: [20723] [2015/04/09 17:13:17.624] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [20723] [2015/04/09 17:13:19.409] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [20723] [2015/04/09 17:13:20.476] Dropping views...

    0:: [20723] [2015/04/09 17:13:21.427] Dropping trigger functions...

    0:: [20723] [2015/04/09 17:13:22.172] Dropping remaining non-dependent functions...

    0:: [20723] [2015/04/09 17:13:23.810] MIGRATE_00885.001 completed successfully

    0:: [20723] [2015/04/09 17:13:23.949] MIGRATE_00885.003 completed successfully

    0:: [20723] [2015/04/09 17:13:24.566] EXCEPTION:  Postgres <-[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )">

        USERINFO: {

            SQLSTATE = 2BP01;

            errorMessage = "ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it\nDETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()\nHINT:  Use DROP ... CASCADE to drop the dependent objects too.\n";

        }

    0:: [20723] [2015/04/09 17:13:24.566] SQL Module failed at statement:

        ------------------------------------------------------------------------------- -------

        DROP FUNCTION dm_current_timestamp();

       

        ------------------------------------------------------------------------------- -------

        -[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )"

    0:: [20723] [2015/04/09 17:13:24.567] Caught unhandled exception -[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )"

    0:: [20723] [2015/04/09 17:13:24.567] Migration failed at MIGRATE_00885.004 (final step is MIGRATE_00886.204)

    0:: [20723] [2015/04/09 17:13:24.764] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [20723] [2015/04/09 17:13:24.769] ShutdownMigrator: 2015-04-10 00:13:24 +0000

    0:: [20723] [2015/04/09 17:13:24.770] BYE

    [22210] [2015/04/09 22:45:34.642] -[SULogFileCollection setGlobalLogLevelPrefix:]: YES

    0:: [22210] [2015/04/09 22:45:34.657]

        ############################################################################### ####

        migration_tool-886.204 (PID:22210, OS:14D131, SERVER:14S1092, ARCH:x86_64) starting

        LA: migration_tool

        ############################################################################### ####

    0:: [22210] [2015/04/09 22:45:34.799] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [22210] [2015/04/09 22:45:35.010] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [22210] [2015/04/09 22:45:35.637] Dropping views...

    0:: [22210] [2015/04/09 22:45:35.638] Dropping trigger functions...

    0:: [22210] [2015/04/09 22:45:35.683] Dropping remaining non-dependent functions...

    0:: [22210] [2015/04/09 22:45:36.515] EXCEPTION:  Postgres <-[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )">

        USERINFO: {

            SQLSTATE = 2BP01;

            errorMessage = "ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it\nDETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()\nHINT:  Use DROP ... CASCADE to drop the dependent objects too.\n";

        }

    0:: [22210] [2015/04/09 22:45:36.548] SQL Module failed at statement:

        ------------------------------------------------------------------------------- -------

        DROP FUNCTION dm_current_timestamp();

       

        ------------------------------------------------------------------------------- -------

        -[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )"

    0:: [22210] [2015/04/09 22:45:36.548] Caught unhandled exception -[PGConnection executeCSQL:] (/SourceCache/RemoteDeviceManagement/RemoteDeviceManagement-886.204/Compiled/Fr amework-Models/Postgres/PGConnection.m:339): "Postgres error 2BP01 (ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it

        DETAIL:  default for table devices column last_update_info_time depends on function dm_current_timestamp()

        HINT:  Use DROP ... CASCADE to drop the dependent objects too.

        )"

    0:: [22210] [2015/04/09 22:45:36.548] Migration failed at MIGRATE_00885.004 (final step is MIGRATE_00886.204)

    0:: [22210] [2015/04/09 22:45:36.842] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [22210] [2015/04/09 22:45:36.847] ShutdownMigrator: 2015-04-10 05:45:36 +0000

    0:: [22210] [2015/04/09 22:45:36.848] BYE

  • by pepmachine,

    pepmachine pepmachine Apr 11, 2015 2:44 AM in response to Frederick G
    Level 1 (5 points)
    Apr 11, 2015 2:44 AM in response to Frederick G

    I had the same problem. Fixed it this way.

    1. Just to be sure, make a full Time Machine backup of your Server.

    2. Archive your open directory master.

    3. Backup your Profile Manager database: How do I backup profile manager database on OS X Yosemite?

    4. Reset Profile Manager to it't original state without losing data (first option): OS X Server: How to reset Profile Manager to its original state - Apple Support

    5. Backup your Certificates in the Keychain Access application. I would backup every Certificate seperatly so you can restore them individually if needed.

    6. Destroy your open directory master.

    7. Create a new open directory master.

    8. Setup profile manager by enabling Device Management.

    9. Destroy your open directory master.

    10. Restore your archived open directory master.

    11. Check if all your Certificates are still in the Keychain and happy. If not, make sure you restore IntermediateCA, Code Signing Certificate and Open Directory Certificate Authority from your backup.

    Hopefully somebody knows a terminal command that will fix it, but if that isn't the case this worked for me.

    Hope it helps.

  • by mscott_mdm,Helpful

    mscott_mdm mscott_mdm Apr 11, 2015 4:59 PM in response to pepmachine
    Level 2 (225 points)
    Apr 11, 2015 4:59 PM in response to pepmachine

    Oh, please, please, please don't do this! This is *beyond* overkill and will leave you with the Profile Manager data you had from before Server 3.0 (if any).

     

    No, there's a very simple fix for this problem. In Terminal, on the server, do this:

     

    sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "ALTER TABLE mdm_targets ALTER COLUMN last_update_info_time SET DEFAULT 'epoch'"


    Then run the setup script (which got moved in Server 4):

     

    sudo /Applications/Server.app/Contents/ServerRoot/usr/libexec/deviceManagerCommon.sh


  • by mscott_mdm,

    mscott_mdm mscott_mdm Apr 11, 2015 8:41 AM in response to mscott_mdm
    Level 2 (225 points)
    Apr 11, 2015 8:41 AM in response to mscott_mdm

    For reference, this is the exact same problem as seen here: Server 4.1 Profile Manager Migration Failed.

  • by pepmachine,

    pepmachine pepmachine Apr 11, 2015 11:31 AM in response to mscott_mdm
    Level 1 (5 points)
    Apr 11, 2015 11:31 AM in response to mscott_mdm

    It seems that my solution is overkill and mscott has the elegant solution so please don't use mine! Thanks mscott!

  • by Frederick G,

    Frederick G Frederick G Apr 11, 2015 12:09 PM in response to mscott_mdm
    Level 1 (0 points)
    Apr 11, 2015 12:09 PM in response to mscott_mdm

    Hi MScott,

     

    I deeply appreciate your help, but this didn't seem to work.  (The steps and results are below.)

     

    Now when I try to go to the Profile Manager pane in Server.app, I get "Error Reading Settings." 

    If I then click "Continue" I get the Profile Manager pane, and have to re configure device manager.

    This seems to work, until it hangs on the final step "Confirm Settings" which errors with code -1.

     

    Any further ideas?

     

    Thanks!

    Frederick

     

     

    Here is what occurred:

     

    home:~$ sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "ALTER TABLE mdm_targets ALTER COLUMN last_update_info_time SET DEFAULT 'epoch'"

    Password:

    ALTER TABLE

     

    I then ran the setup script again:

     

    home:~$ sudo /Applications/Server.app/Contents/ServerRoot/usr/libexec/deviceManagerCommon.sh

    2015-04-11 11:48:07 deviceManagerCommon.sh: Starting...

    2015-04-11 11:48:07 deviceManagerCommon.sh: Ensuring Profile Manager services are unloaded and terminated...

    {

    }

    {

    }

    No matching processes were found

    No matching processes were found

    2015-04-11 11:48:19.793 serverctl[84553:1581800] ERROR: The operation couldn’t be completed. Operation not permitted

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/FileStore: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/tmp: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/tmp/php_sessions: File exists

    2015-04-11 11:49:13 deviceManagerCommon.sh: A postgres cluster appers to already exist at /Library/Server/ProfileManager/Config/ServiceData/Data/PostgreSQL

    2015-04-11 11:49:13 deviceManagerCommon.sh: Pre-flight starting postgres...

    2015-04-11 11:49:13 deviceManagerCommon.sh: Started xpostgres with PID 4164

    2015-04-11 11:49:13 XPG.4167:  Process parent is PID 4164

    could not identify current directory: Permission denied

    2015-04-11 11:49:13 XPG.4167:  Excluding data directory.

    2015-04-11 11:49:13 XPG.4167:  Turning on archive logging.

    2015-04-11 11:49:14 XPG.4167:  Cleaning up any existing postmaster.pid file

    2015-04-11 11:49:14 XPG.4167:  Starting postgres.

    2015-04-11 11:49:14 XPG.4167:  Waiting for data directory: /Library/Server/ProfileManager/Config/ServiceData/Data/PostgreSQL

    2015-04-11 11:49:14 XPG.4167:  Data directory exists.

    2015-04-11 11:49:14 XPG.4167:  Spawning postgres now.

    2015-04-11 11:49:14 XPG.4167:  Waiting for socket to appear in socket directory: /Library/Server/ProfileManager/Config/var/PostgreSQL

    LOG:  00000: could not identify current directory: Permission denied

    LOCATION:  find_my_exec, exec.c:128

    LOG:  00000: could not identify current directory: Permission denied

    LOCATION:  find_my_exec, exec.c:128

    FATAL:  XX000: /Applications/Server.app/Contents/ServerRoot/usr/bin/postgres_real: could not locate my own executable path

    LOCATION:  getInstallationPaths, postmaster.c:1288

    2015-04-11 11:49:14 XPG.4167:  Postgres exited.

    2015-04-11 11:49:14 deviceManagerCommon.sh: The postgres server with PID 4164 died before responding to connections. We die here, too.

    home:~$

  • by mscott_mdm,Solvedanswer

    mscott_mdm mscott_mdm Apr 11, 2015 4:47 PM in response to Frederick G
    Level 2 (225 points)
    Apr 11, 2015 4:47 PM in response to Frederick G

    This is a different problem. I would drag Server.app to the Trash, wait for the dialog detecting server being moved to the trash to pop up, then reinstall Server from the App Store and try again.

  • by Frederick G,

    Frederick G Frederick G Apr 11, 2015 5:03 PM in response to mscott_mdm
    Level 1 (0 points)
    Apr 11, 2015 5:03 PM in response to mscott_mdm

    Hi MScott,

     

    Magic!  Thanks, that did the trick.

     

    I am curious how you recognized the issue.  If you can give me insight into what you saw in the logs that led to your first and second answers, I'd really appreciate it.

     

    Again, thank you!

    Frederick

  • by mscott_mdm,

    mscott_mdm mscott_mdm Apr 11, 2015 8:39 PM in response to Frederick G
    Level 2 (225 points)
    Apr 11, 2015 8:39 PM in response to Frederick G

    Frederick,

     

    I'm glad I could help. I have a pretty deep background with Postgres and the message "ERROR:  cannot drop function dm_current_timestamp() because other objects depend on it" is pretty straightforward. Checking a clean PM install, I see that the column mentioned by the DETAIL note ["default for table devices column last_update_info_time depends on function dm_current_timestamp()"] does not have this default value, but rather it has the default value of 'epoch'. Since these are both SQL timestamp values, it's easy to change the default value, which removes the dependency. But Profile Manager has already failed its upgrade because of this, so in addition to fixing the dependency problem, it is necessary to get Profile Manager to re-run it's upgrade code. That's what the 2nd command was for. (Re-running the upgrade code usually works because the upgrade steps are performed inside of SQL transactions, so the failure causes the database to be left in a known—but not correct—state, so just running the upgrade code again lets it continue where it left off.)

     

    In your case, something else went wrong during this 2nd step, pretty clearly with Postgres itself. (Looked like a permissions error.) On this particular error, I was semi-guessing that the remove/reinstall would fix it. Removing Server will shutdown all the services and processes without disturbing any of the data, so it's generally pretty safe to remove and re-install. I kinda just got lucky on this one.

  • by Frederick G,

    Frederick G Frederick G Apr 11, 2015 10:35 PM in response to mscott_mdm
    Level 1 (0 points)
    Apr 11, 2015 10:35 PM in response to mscott_mdm

    MScott,

     

    Well, lucky on not on that last step, it did the trick.  Thank you!  And thanks for the explanation.

     

    Frederick

  • by ChazzaDK,

    ChazzaDK ChazzaDK Jul 13, 2015 5:07 AM in response to mscott_mdm
    Level 1 (5 points)
    Jul 13, 2015 5:07 AM in response to mscott_mdm

    Hello All

     

    I've been having a "get_AUTH" error with profile manager since a time machine backup/restore to a new drive (following Apple's advice). Haven't been able to connect at all. I've done the following:

     

    STEP 1


    Command to show admin user row in the users table

     

    sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "select * from public.users where short_name = 'admin'"

     


    STEP 2

     

    I have tried this terminal command and indeed I seem to have 0 users. Which would explain why I get the "auth_token doesn’t exist” error each time I try to connect.

     

     

    server:~ Server$ sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "select * from public.users where short_name = 'admin'"

     

    Password:

    id | admin_temp_id | created_at | updated_at | library_item_type | order_name | updated_at_xid | od_node_id | guid | short_name | full_name | last_synced | privileges | uid | primary_group_id | first_name | last_name | job_title | mobile_phone | email | seen_admin | vpp_status | vpp_status_ext | vpp_invite_code | vpp_its_account_id | vpp_status_updated_at | vpp_last_synced | vpp_email_address

    ----+---------------+------------+------------+-------------------+------------+ ----------------+------------+------+------------+-----------+-------------+---- --------+-----+------------------+------------+-----------+-----------+--------- -----+-------+------------+------------+----------------+-----------------+----- ---------------+-----------------------+-----------------+-------------------

    (0 rows)

     

    STEP 3


    As a result I decided to test again wiping the database using this command “sudo /Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/backend/wipeDB .sh”. From this I got the following in Terminal "WARNING:  >>>>> Creating new database schema <<<<<

    NOTICE:  aggregate array_agg_strict(anyelement) does not exist, skipping

    NOTICE:  aggregate first(anyelement) does not exist, skipping

    NOTICE:  function _dm_after_asset_updated(assets,assets) does not exist, skipping

    NOTICE:  function _dm_after_library_item_tasks_update() does not exist, skipping

    NOTICE:  trigger "dm_trigger_after_insert_od_searches" for table "od_searches" does not exist, skipping

    NOTICE:  function _dm_after_abstract_user_deleted(abstract_users) does not exist, skipping

    NOTICE:  trigger "dm_trigger_user_uniqueness_checks" for table "users" does not exist, skipping

    NOTICE:  trigger "dm_trigger_user_group_uniqueness_checks" for table "user_groups" does not exist, skipping

    NOTICE:  trigger "dm_trigger_user_group_membership_checks" for table "user_groups" does not exist, skipping

    NOTICE:  trigger "dm_trigger_inactive_user_group_uniqueness_checks" for table "inactive_user_groups" does not exist, skipping

    NOTICE:  trigger "dm_trigger_inactive_user_uniqueness_checks" for table "inactive_users" does not exist, skipping

    NOTICE:  trigger "dm_trigger_inactive_user_group_memberships_active_group_check" for table "inactive_user_group_memberships" does not exist, skipping

    NOTICE:  trigger "dm_trigger_inactive_user_groups_users_active_group_check" for table "inactive_user_groups_users" does not exist, skipping

    NOTICE:  trigger "dm_trigger_before_modify_owner_lab_sessions_common" for table "owner_lab_sessions" does not exist, skipping

    NOTICE:  view "view_needed_eapp_remove_tasks" does not exist, skipping

    NOTICE:  view "view_needed_ebook_remove_tasks" does not exist, skipping

    {

    }

    devicemgr:state = "RUNNING"

    Sending (asynchronously) command noOp

    which seems to show that certain functions are all missing and therefore skipped in the creation of the new DB.


    STEP 4


    I then wiped & restored from back up by typing "sudo -s” into terminal followed by "cat ~/Desktop/profileManager.sql | psql -h /Library/Server/ProfileManager/Config/var/PostgreSQL -U _devicemgr devicemgr_v2m0” (all this from this page https://discussions.apple.com/thread/6855393)


    STEP 5


    I then re-ran the command sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "select * from public.users where short_name = 'admin’” and once again see that there are no users listed.


     

    bash-3.2# sudo psql -U _devicemgr -d devicemgr_v2m0 -h /Library/Server/ProfileManager/Config/var/PostgreSQL -c "select * from public.users where short_name = 'admin'"

     

    id | admin_temp_id | created_at | updated_at | library_item_type | order_name | updated_at_xid | od_node_id | guid | short_name | full_name | last_synced | privileges | uid | primary_group_id | first_name | last_name | job_title | mobile_phone | email | seen_admin | vpp_status | vpp_status_ext | vpp_invite_code | vpp_its_account_id | vpp_status_updated_at | vpp_last_synced | vpp_email_address

    ----+---------------+------------+------------+-------------------+------------+ ----------------+------------+------+------------+-----------+-------------+---- --------+-----+------------------+------------+-----------+-----------+--------- -----+-------+------------+------------+----------------+-----------------+----- ---------------+-----------------------+-----------------+-------------------

    (0 rows)

    STEP 6


    I then tried re-connection to the profile manager portal and got these error messages in the log

    "0:: [22605] [2015/07/13 13:42:58.710] -[SULogFileCollection setGlobalLogLevelPrefix:]: NO

    [22596] [2015/07/13 13:43:06.416] I: Processing ApplicationController#alive (for 127.0.0.1 at 2015-07-13 13:43:06) [GET]

    [22596] [2015/07/13 13:43:06.419] I: Completed in 2ms (View: 1, DB: 2) | 200 OK [http://127.0.0.1/application/alive]

    [22596] [2015/07/13 13:43:15.476] I: Processing MagicController#admin_will_load (for 192.168.37.27 at 2015-07-13 13:43:15) [POST]

    [22596] [2015/07/13 13:43:15.478] I: auth_token doesn't exist

    [22596] [2015/07/13 13:43:15.479] I: Filter chain halted as [:verify_auth_token] rendered_or_redirected.

    [22596] [2015/07/13 13:43:15.479] I: Completed in 3ms (View: 0, DB: 1) | 403 Forbidden [https://server.nordeqmanagement.com/magic/admin_will_load]

    [22597] [2015/07/13 13:43:16.384] I: Processing MagicController#do_magic (for 192.168.37.27 at 2015-07-13 13:43:16) [POST]

    [22597] [2015/07/13 13:43:16.386] I: auth_token doesn't exist

    [22597] [2015/07/13 13:43:16.387] I: Filter chain halted as [:verify_auth_token] rendered_or_redirected.

    [22597] [2015/07/13 13:43:16.387] I: Completed in 2ms (View: 0, DB: 3) | 403 Forbidden [https://server.nordeqmanagement.com/magic/do_magic]

    Once again is would see I get an “auth_token doesn’t exist” error.

    To be clear - when I turn off profile manager then I get a different error saying the service is not running (which is correct). Therefore the server seems to be running and all ports correctly opened - it just doesn’t connect to the OD service to identify the users.


    STEP 7


    I then ran the two commands you suggest on this thread - this came out on the log. There seem to be postgres errors  - log receiver: pg_receivexlog: could not connect to server: FATAL:  the database system is shutting down

     

    pg_receivexlog: disconnected; waiting 5 seconds to try again

    2015-07-13 13:49:30 XPG.31404:  Postgres exited.

    2015-07-13 13:49:30 XPG.31404:  pg_receivexlog still running; terminating.

    2015-07-13 13:49:30 XPG.31404:  log receiver: pg_receivexlog: could not connect to server: could not connect to server: No such file or directory

      Is the server running locally and accepting

      connections on Unix domain socket "/Library/Server/ProfileManager/Config/var/PostgreSQL/.s.PGSQL.5432"?

     

    Does anyone have any idea how to get this working again? I would rather not do a complete DB wipe and having to re-import all devices but I will if I need to of course.

     

    Thanks a million in advance for all your help.

     

    Cheers

     

    Charlie

  • by Bosco1983,

    Bosco1983 Bosco1983 Dec 1, 2015 6:29 AM in response to Frederick G
    Level 1 (61 points)
    Servers Enterprise
    Dec 1, 2015 6:29 AM in response to Frederick G

    Ive got a similar problem - profile manager often shows the "reload page" message and is often unusable

     

    Migration tool log here.  Ive tried the 2 fixes from mscott but no joy Any help would be awesome.

    El Cap server 5

     

    2:: [75646] [2015/11/30 14:35:52.918] PSQLCommand RESULT:

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————— [0m

        COMMAND | /Applications/Server.app/Contents/ServerRoot/usr/bin/psql -c SELECT COUNT(*) FROM dm_schema_information CROSS JOIN settings -d devicemgr_v2m0 -U _devicemgr -h /Library/Server/ProfileManager/Config/var/PostgreSQL -At

        WD      | /Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————— [0m

        STATUS  | 0

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————— [0m

        STDERR  |

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————— [0m

        STDOUT  | 1

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————— [0m

    3:: [75646] Returned connection [<PGconnObj:0x7fac32602880> connection #1 in pool template1@_devicemgr]

    0:: [75646] [2015/11/30 14:35:52.920] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = YES, DBLogSQL = NO, DBMonitor = NO

    3:: [75646] void bunzip2FilePaths(NSString *__strong, NSString *__strong)('/Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/mi gration/v2m1.dmmd.bz2', '/Library/Server/ProfileManager/Config/ServiceData/Data/tmp/.rdmtemp.,Vs1q,,,,, 8-yF5cVmdFi2s.noindex')

    2:: [75646] [2015/11/30 14:35:52.955] Opening new connection to PostgreSQL database 'migration_failed__do_not_manually_rename__you_have_been_warned' as user '_devicemgr' on socket '/Library/Server/ProfileManager/Config/var/PostgreSQL'

    2:: [75646] [2015/11/30 14:35:52.976] Created connection [<PGconnObj:0x7fac32532ce0> connection #1 in pool migration_failed__do_not_manually_rename__you_have_been_warned@_devicemgr]

    3:: [75646] Readying connection [<PGconnObj:0x7fac32532ce0> connection #1 in pool migration_failed__do_not_manually_rename__you_have_been_warned@_devicemgr]

    2:: [75646] [2015/11/30 14:35:53.005] Registering PGModel 'KnobSet' (table 'knob_sets')

    2:: [75646] [2015/11/30 14:35:53.043] Registering PGModel 'DMODNodeRef' (table 'od_nodes')

    2:: [75646] [2015/11/30 14:35:53.050] Registering PGModel 'AssetMetadata' (table 'asset_metadata')

    2:: [75646] [2015/11/30 14:35:53.057] Registering PGModel 'JTUserGroups_UsersFlat' (table 'view_user_groups_users_flat')

    2:: [75646] [2015/11/30 14:35:53.061] Registering PGModel 'LibraryItem' (table 'library_items')

    2:: [75646] [2015/11/30 14:35:53.068] Registering PGModel 'ODLibraryItem' (table 'od_library_items')

    2:: [75646] [2015/11/30 14:35:53.072] Registering PGModel 'AbstractUserGroup' (table 'abstract_user_groups')

    2:: [75646] [2015/11/30 14:35:53.079] Registering PGModel 'InactiveUserGroup' (table 'inactive_user_groups')

    2:: [75646] [2015/11/30 14:35:53.088] Registering PGModel 'DeviceEnrollmentSettings' (table 'device_enrollment_settings')

    2:: [75646] [2015/11/30 14:35:53.097] Registering PGModel 'JTLibraryItems_Assets' (table 'library_items_assets')

    2:: [75646] [2015/11/30 14:35:53.105] Registering PGModel 'ViewActiveUserVPPEmailInvitationTasks' (table 'view_active_user_vpp_email_invitation_tasks')

    2:: [75646] [2015/11/30 14:35:53.111] Registering PGModel 'Asset' (table 'assets')

    2:: [75646] [2015/11/30 14:35:53.118] Registering PGModel 'JTDeviceGroupsFlat' (table 'view_device_groups_flat')

    2:: [75646] [2015/11/30 14:35:53.121] Registering PGModel 'Media' (table 'media')

    2:: [75646] [2015/11/30 14:35:53.125] Registering PGModel 'InstalledMedia' (table 'installed_media')

    2:: [75646] [2015/11/30 14:35:53.133] Registering PGModel 'InstalledApplication' (table 'installed_applications')

    2:: [75646] [2015/11/30 14:35:53.140] Registering PGModel 'JTKnobSets_Widgets' (table 'knob_sets_widgets')

    2:: [75646] [2015/11/30 14:35:53.146] Registering PGModel 'Widget' (table 'widgets')

    2:: [75646] [2015/11/30 14:35:53.153] Registering PGModel 'JTInstalledProfiles' (table 'installed_profiles')

    2:: [75646] [2015/11/30 14:35:53.161] Registering PGModel 'MDMTarget' (table 'mdm_targets')

    2:: [75646] [2015/11/30 14:35:53.169] Registering PGModel 'Device' (table 'devices')

    2:: [75646] [2015/11/30 14:35:53.177] Registering PGModel 'LabSession' (table 'lab_sessions')

    2:: [75646] [2015/11/30 14:35:53.185] Registering PGModel 'LibraryItemMetadata' (table 'library_item_metadata')

    2:: [75646] [2015/11/30 14:35:53.192] Registering PGModel 'JTUserGroupMemberships' (table 'user_group_memberships')

    2:: [75646] [2015/11/30 14:35:53.199] Registering PGModel 'JTKnobSets_Printers' (table 'knob_sets_printers')

    2:: [75646] [2015/11/30 14:35:53.206] Registering PGModel 'Printer' (table 'printers')

    2:: [75646] [2015/11/30 14:35:53.214] Registering PGModel 'DynamicAttributesDefaults' (table 'dynamic_attributes_defaults')

    2:: [75646] [2015/11/30 14:35:53.220] Registering PGModel 'JTOSUpdates_Devices' (table 'os_updates_devices')

    2:: [75646] [2015/11/30 14:35:53.227] Registering PGModel 'OSUpdate' (table 'os_updates')

    2:: [75646] [2015/11/30 14:35:53.234] Registering PGModel 'EnterpriseApp' (table 'enterprise_apps')

    2:: [75646] [2015/11/30 14:35:53.242] Registering PGModel 'TargetTombstone' (table 'target_tombstones')

    2:: [75646] [2015/11/30 14:35:53.251] Registering PGModel 'JTKnobSets_SystemApplications' (table 'knob_sets_system_applications')

    2:: [75646] [2015/11/30 14:35:53.259] Registering PGModel 'SystemApplication' (table 'system_applications')

    2:: [75646] [2015/11/30 14:35:53.271] Registering PGModel 'JTDeviceGroups_DevicesFlat' (table 'view_device_groups_devices_flat')

    2:: [75646] [2015/11/30 14:35:53.277] Registering PGModel 'JTAbstractUserGroups_Users' (table 'abstract_user_groups_users')

    2:: [75646] [2015/11/30 14:35:53.281] Registering PGModel 'AbstractUser' (table 'abstract_users')

    2:: [75646] [2015/11/30 14:35:53.290] Registering PGModel 'ViewNeededDEPProfilesAssignments' (table 'view_needed_dep_profiles_assignments')

    2:: [75646] [2015/11/30 14:35:53.295] Registering PGModel 'VppAssignedLicense' (table 'vpp_assigned_licenses')

    2:: [75646] [2015/11/30 14:35:53.302] Registering PGModel 'AutoJoinProfile' (table 'auto_join_profiles')

    2:: [75646] [2015/11/30 14:35:53.311] Registering PGModel 'ViewPendingPushNotifications' (table 'view_pending_push_notifications')

    2:: [75646] [2015/11/30 14:35:53.316] Registering PGModel 'WorkTask' (table 'work_tasks')

    2:: [75646] [2015/11/30 14:35:53.323] Registering PGModel 'UserTask' (table 'user_tasks')

    2:: [75646] [2015/11/30 14:35:53.330] Registering PGModel 'OwnerLabSession' (table 'owner_lab_sessions')

    2:: [75646] [2015/11/30 14:35:53.337] Registering PGModel 'Book' (table 'ebooks')

    2:: [75646] [2015/11/30 14:35:53.347] Registering PGModel 'LibraryItemTask' (table 'library_item_tasks')

    2:: [75646] [2015/11/30 14:35:53.354] Registering PGModel 'User' (table 'users')

    2:: [75646] [2015/11/30 14:35:53.368] Registering PGModel 'DataFile' (table 'data_files')

    2:: [75646] [2015/11/30 14:35:53.375] Registering PGModel 'JTUserGroupsFlat' (table 'view_user_groups_flat')

    2:: [75646] [2015/11/30 14:35:53.380] Registering PGModel 'NetworkLabSession' (table 'network_lab_sessions')

    2:: [75646] [2015/11/30 14:35:53.387] Registering PGModel 'DMODSearch' (table 'od_searches')

    2:: [75646] [2015/11/30 14:35:53.393] Registering PGModel 'DeviceGroup' (table 'device_groups')

    2:: [75646] [2015/11/30 14:35:53.400] Registering PGModel 'JTAbstractUserGroupMemberships' (table 'abstract_user_group_memberships')

    2:: [75646] [2015/11/30 14:35:53.403] Registering PGModel 'JTDeviceGroups_Devices' (table 'device_groups_devices')

    2:: [75646] [2015/11/30 14:35:53.410] Registering PGModel 'Settings' (table 'settings')

    2:: [75646] [2015/11/30 14:35:53.417] Registering PGModel 'CompletedTask' (table 'completed_tasks')

    2:: [75646] [2015/11/30 14:35:53.424] Registering PGModel 'MDMTask' (table 'mdm_tasks')

    2:: [75646] [2015/11/30 14:35:53.431] Registering PGModel 'DMSchemaInformation' (table 'dm_schema_information')

    2:: [75646] [2015/11/30 14:35:53.437] Registering PGModel 'InactiveUser' (table 'inactive_users')

    2:: [75646] [2015/11/30 14:35:53.446] Registering PGModel 'JTInactiveUserGroups_Users' (table 'inactive_user_groups_users')

    2:: [75646] [2015/11/30 14:35:53.451] Registering PGModel 'JTKnobSets_Assets' (table 'knob_sets_assets')

    2:: [75646] [2015/11/30 14:35:53.457] Registering PGModel 'ViewNeededDEPProfilesRemovals' (table 'view_needed_dep_profiles_removals')

    2:: [75646] [2015/11/30 14:35:53.461] Registering PGModel 'JTDeviceGroupMemberships' (table 'device_group_memberships')

    2:: [75646] [2015/11/30 14:35:53.469] Registering PGModel 'PGDatabaseNotification' (table 'db_notifications')

    2:: [75646] [2015/11/30 14:35:53.478] Registering PGModel 'JTUserGroups_Users' (table 'user_groups_users')

    2:: [75646] [2015/11/30 14:35:53.482] Registering PGModel 'UserGroup' (table 'user_groups')

    2:: [75646] [2015/11/30 14:35:53.491] Registering PGModel 'DMCertificate' (table 'certificates')

    2:: [75646] [2015/11/30 14:35:53.498] Registering PGModel 'JTKnobSets_Devices' (table 'knob_sets_devices')

    2:: [75646] [2015/11/30 14:35:53.508] Registering PGModel 'PreferencePane' (table 'preference_panes')

    2:: [75646] [2015/11/30 14:35:53.516] Registering PGModel 'VppProduct' (table 'vpp_products')

    2:: [75646] [2015/11/30 14:35:53.525] Registering PGModel 'DMInternalTask' (table 'internal_tasks')

    2:: [75646] [2015/11/30 14:35:53.533] Registering PGModel 'JTInactiveUserGroupMemberships' (table 'inactive_user_group_memberships')

    2:: [75646] [2015/11/30 14:35:53.539] Registering PGModel 'Profile' (table 'profiles')

    2:: [75646] [2015/11/30 14:35:53.542] Registering PGModel 'InstalledBooks' (table 'installed_books')

    3:: [75646] void bunzip2FilePaths(NSString *__strong, NSString *__strong)('/Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/mi gration/v2m1.dmmd.bz2', '/Library/Server/ProfileManager/Config/ServiceData/Data/tmp/.rdmtemp.,Vs1q,,,,, 8-yV5cVsYjezI.noindex')

    3:: [75646] Returned connection [<PGconnObj:0x7fac32532ce0> connection #1 in pool migration_failed__do_not_manually_rename__you_have_been_warned@_devicemgr]

    3:: [75646] PSQLCommand RESULT:

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— —————————————————— [0m

        COMMAND | /Applications/Server.app/Contents/ServerRoot/usr/bin/psql -c select version(); -d template1 -U _devicemgr -h /Library/Server/ProfileManager/Config/var/PostgreSQL

        WD      | /Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— —————————————————— [0m

        STATUS  | 0

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— —————————————————— [0m

        STDERR  |

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— —————————————————— [0m

        STDOUT  | version                                                   

                | ------------------------------------------------------------------------------- -------------------------------

                |  PostgreSQL 9.3.9 on x86_64-apple-darwin13.0, compiled by Apple LLVM version 7.0.0 (clang-700.0.59.1), 64-bit

                | (1 row)

         [1;32m————————+———————————————————————————————————————————————————————————————— ———————————————————————————————————————————————————————————————————————————————— —————————————————— [0m

    0:: [75646] [2015/11/30 14:35:53.727] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = YES, DBLogSQL = NO, DBMonitor = NO

    2:: [75646] [2015/11/30 14:35:53.727] Opening new connection to PostgreSQL database 'template1' as user '_devicemgr' on socket '/Library/Server/ProfileManager/Config/var/PostgreSQL'

    2:: [75646] [2015/11/30 14:35:53.734] Created connection [<PGconnObj:0x7fac348003f0> connection #1 in pool template1@_devicemgr]

    3:: [75646] Readying connection [<PGconnObj:0x7fac348003f0> connection #1 in pool template1@_devicemgr]

    3:: [75646] Returned connection [<PGconnObj:0x7fac348003f0> connection #1 in pool template1@_devicemgr]

    0:: [75646] [2015/11/30 14:35:53.739] ShutdownMigrator: 2015-11-30 14:35:53 +0000

    2:: [75646] [2015/11/30 14:35:53.739] void ErasePIDFile(): pidFilePath = '/Library/Server/ProfileManager/Config/var/migration_tool'

    0:: [75646] [2015/11/30 14:35:53.740] BYE

    [23895] [2015/11/30 15:29:15.267] -[SULogFileCollection setGlobalLogLevelPrefix:]: YES

    0:: [23895] [2015/11/30 15:29:15.268]

        ############################################################################### #

        migration_tool-889.8 (PID:23895, OS:15B42, SERVER:15S4033, ARCH:x86_64) starting

        LA: migration_tool

        Log verbosity level = 1

        UID = 220, EUID = 220

        ############################################################################### #

    0:: [23895] [2015/11/30 15:29:15.268] WaitForPostgresToStart

    0:: [23895] [2015/11/30 15:29:15.332] Waiting for postgres to startup....

    0:: [23895] [2015/11/30 15:29:16.877] DisablePostgresBackups

    0:: [23895] [2015/11/30 15:29:16.941] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [23895] [2015/11/30 15:29:17.614] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [23895] [2015/11/30 15:29:18.908] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [23895] [2015/11/30 15:29:18.918] ShutdownMigrator: 2015-11-30 15:29:18 +0000

    0:: [23895] [2015/11/30 15:29:18.918] BYE

    [46783] [2015/11/30 15:45:55.791] -[SULogFileCollection setGlobalLogLevelPrefix:]: YES

    0:: [46783] [2015/11/30 15:45:55.792]

        ############################################################################### #

        migration_tool-889.8 (PID:46783, OS:15B42, SERVER:15S4033, ARCH:x86_64) starting

        LA: migration_tool

        Log verbosity level = 1

        UID = 220, EUID = 220

        ############################################################################### #

    0:: [46783] [2015/11/30 15:45:55.792] WaitForPostgresToStart

    0:: [46783] [2015/11/30 15:45:55.857] Waiting for postgres to startup....

    0:: [46783] [2015/11/30 15:45:57.402] DisablePostgresBackups

    0:: [46783] [2015/11/30 15:45:57.466] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [46783] [2015/11/30 15:45:57.704] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [46783] [2015/11/30 15:45:58.674] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [46783] [2015/11/30 15:45:58.727] ShutdownMigrator: 2015-11-30 15:45:58 +0000

    0:: [46783] [2015/11/30 15:45:58.728] BYE

    [70096] [2015/11/30 16:23:41.345] -[SULogFileCollection setGlobalLogLevelPrefix:]: YES

    0:: [70096] [2015/11/30 16:23:41.346]

        ############################################################################### #

        migration_tool-889.8 (PID:70096, OS:15B42, SERVER:15S4033, ARCH:x86_64) starting

        LA: migration_tool

        Log verbosity level = 1

        UID = 220, EUID = 220

        ############################################################################### #

    0:: [70096] [2015/11/30 16:23:41.346] WaitForPostgresToStart

    0:: [70096] [2015/11/30 16:23:41.410] Waiting for postgres to startup....

    0:: [70096] [2015/11/30 16:23:42.729] DisablePostgresBackups

    0:: [70096] [2015/11/30 16:23:42.792] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [70096] [2015/11/30 16:23:42.926] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [70096] [2015/11/30 16:23:43.682] +[PGConnection reloadPreferences]: DBDebug = NO, DBLogNotices = NO, DBLogSQL = NO, DBMonitor = NO

    0:: [70096] [2015/11/30 16:23:43.692] ShutdownMigrator: 2015-11-30 16:23:43 +0000

    0:: [70096] [2015/11/30 16:23:43.692] BYE

  • by Bosco1983,

    Bosco1983 Bosco1983 Dec 1, 2015 6:48 AM in response to Bosco1983
    Level 1 (61 points)
    Servers Enterprise
    Dec 1, 2015 6:48 AM in response to Bosco1983

    Log from running deviceManagerCommon.sh

     

    2015-12-01 14:45:07 deviceManagerCommon.sh: Starting...

    2015-12-01 14:45:07 deviceManagerCommon.sh: Ensuring Profile Manager services are unloaded and terminated...

    {

    }

    {

    }

    No matching processes were found

    No matching processes were found

    {

    }

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/FileStore: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/tmp: File exists

    mkdir: /Library/Server/ProfileManager/Config/ServiceData/Data/tmp/php_sessions: File exists

    2015-12-01 14:47:14 deviceManagerCommon.sh: A postgres cluster appers to already exist at /Library/Server/ProfileManager/Config/ServiceData/Data/PostgreSQL

    2015-12-01 14:47:14 deviceManagerCommon.sh: Pre-flight starting postgres...

    2015-12-01 14:47:14 deviceManagerCommon.sh: Started xpostgres with PID 42184

    psql: could not connect to server: No such file or directory

      Is the server running locally and accepting

      connections on Unix domain socket "/Library/Server/ProfileManager/Config/var/PostgreSQL/.s.PGSQL.5432"?

    2015-12-01 14:47:15 deviceManagerCommon.sh: Waiting for postgres to fully start...2015-12-01 14:47:15 XPG.42187:  Process parent is PID 42184

    2015-12-01 14:47:15 XPG.42187:  Excluding data directory.

    .2015-12-01 14:47:16 XPG.42187:  Turning on archive logging.

    2015-12-01 14:47:16 XPG.42187:  Cleaning up any existing postmaster.pid file

    2015-12-01 14:47:16 XPG.42187:  Cleaning up any existing socket lock file

    2015-12-01 14:47:16 XPG.42187:  Starting postgres.

    2015-12-01 14:47:16 XPG.42187:  Waiting for data directory: /Library/Server/ProfileManager/Config/ServiceData/Data/PostgreSQL

    2015-12-01 14:47:16 XPG.42187:  Data directory exists.

    2015-12-01 14:47:16 XPG.42187:  Spawning postgres now.

    2015-12-01 14:47:16 XPG.42187:  Waiting for socket to appear in socket directory: /Library/Server/ProfileManager/Config/var/PostgreSQL

    2015-12-01 14:47:16.917 GMT LOG:  redirecting log output to logging collector process

    2015-12-01 14:47:16.917 GMT HINT:  Future log output will appear in directory "/Library/Logs/ProfileManager".

    2015-12-01 14:47:17 deviceManagerCommon.sh: Running!

    2015-12-01 14:47:17 deviceManagerCommon.sh: Stopping postgres pre-flight instance...

    2015-12-01 14:47:17 XPG.42187:  Socket available; starting should now be complete.

    2015-12-01 14:47:17 XPG.42187:  log receiver: pg_receivexlog: starting log streaming at 8/8B000000 (timeline 2)

    2015-12-01 14:47:17 XPG.42187:  Starting backup heartbeat.

    2015-12-01 14:47:18 XPG.42187:  Decremented reference count. Count is now: 0

    2015-12-01 14:47:18 XPG.42187:  Reference count reached zero.  Shutting down.

    2015-12-01 14:47:18 XPG.42187:  Killing idle connections...

    2015-12-01 14:47:18 XPG.42187:  Spawning... ('/Applications/Server.app/Contents/ServerRoot/usr/bin/psql', '-q', '-h', '/Library/Server/ProfileManager/Config/var/PostgreSQL', '-d', 'postgres', '-c', "SELECT pid, (SELECT pg_terminate_backend(pid)) as killed from pg_stat_activity WHERE state LIKE 'idle';")

    pid | killed

    -----+--------

    (0 rows)

     

    2015-12-01 14:47:19 XPG.42187:  log receiver: pg_receivexlog: finished segment at 8/8C000000 (timeline 2)

    2015-12-01 14:47:21 XPG.42187:  Postgres exited.

    2015-12-01 14:47:21 XPG.42187:  pg_receivexlog still running; terminating.

    2015-12-01 14:47:21 XPG.42187:  log receiver: pg_receivexlog: not renaming "00000002000000080000008C.partial", segment is not complete

    pg_receivexlog: received interrupt signal, exiting

    2015-12-01 14:47:21 deviceManagerCommon.sh: Starting postgres under launchd...

    {

    }

    {

    }

    2015-12-01 14:47:21 deviceManagerCommon.sh: Migrating PM SACL in OD...

    <dscl_cmd> DS Error: -14136 (eDSRecordNotFound)

    PM SACL group has already been migrated

    2015-12-01 14:47:21 deviceManagerCommon.sh: Preparing/migrating database...

    {

    }

    2015-12-01 14:47:24 deviceManagerCommon.sh: Done!