Details about this thread
  • State Not Answered
  • Replies 14 replies
  • Subscribers 293 subscribers
  • Views 4045 views
  • Users 0 members are here
Related content from around SugarClub

Module loader shows nothing after upload of custom package

Community Alumni User
after uploading a module in module loader for 6.5.15 for MailMergeReports-Basic-v2.0.5-Sugar_6.5.zip nothing shows up...just goes to a blank screen with sales / home...and nothing...when you goto the module loader nothing shows up on that section either...

Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] current_language is: en_us
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCachesMash
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheAPC
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Using cache backend SugarCacheAPC, since 940 is less than 1000
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheFile
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemcache
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemcached
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemory
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheRedis
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheWincache
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheZend
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query:SELECT category, name, value FROM config
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query Execution Time:0.00024199485778809
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query Execution Time:0.00014495849609375
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query Execution Time:0.00012397766113281
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Hook called: ::after_entry_point
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Including Ext hook file for custom/application
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Hook called: ::after_session_start
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] We have an authenticated user id: 1
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Hook called: Users::before_retrieve
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Including module specific hook file for custom/modules/Users
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Retrieve User : SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0
Sat Mar  1 19:52:03 2014 [42337][-none-][DEBUG] Limit Query:SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0 Start: 0 count: 1
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query:SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0 LIMIT 0,1
Sat Mar  1 19:52:03 2014 [42337][-none-][INFO] Query Execution Time:0.00023198127746582
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '1' and u1.deleted=0
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00018095970153809
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '1'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00031590461730957
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Hook called: Users::after_retrieve
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Current user is: admin
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Current user is: admin
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] setting cookie ck_login_id_20 to 1
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] setting cookie ck_login_language_20 to en_us
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] current_language is: en_us
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT category, name, value FROM config WHERE category = 'license'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00019598007202148
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:9.7990036010742E-5
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00011897087097168
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Module:Administration using file: UpgradeWizard
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT category, name, value FROM config WHERE category = 'tracker'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00016903877258301
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:9.7990036010742E-5
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00011801719665527
Sat Mar  1 19:52:03 2014 [42337][1][WARN] Image icon_Administration_32.png not found
Sat Mar  1 19:52:03 2014 [42337][1][WARN] Image icon_Administration_32.png not found
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Limit Query:SELECT item_id, item_summary, module_name, id FROM tracker WHERE id = (SELECT MAX(id) as id FROM tracker WHERE user_id = '1' AND deleted = 0 AND visible = 1) Start: 0 count: 50
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT item_id, item_summary, module_name, id FROM tracker WHERE id = (SELECT MAX(id) as id FROM tracker WHERE user_id = '1' AND deleted = 0 AND visible = 1) LIMIT 0,50
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00032305717468262
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Tracker: retrieving 10 items
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT category, name, value FROM config WHERE category = 'MySettings'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.0001671314239502
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:9.8943710327148E-5
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:52:03 2014 [42337][1][INFO] Query Execution Time:0.00012087821960449
Sat Mar  1 19:52:03 2014 [42337][1][WARN] Image dashboard.png not found
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Hook called: ::server_round_trip
Sat Mar  1 19:52:03 2014 [42337][1][DEBUG] Calling MySQLi::disconnect()
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] current_language is: en_us
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCachesMash
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheAPC
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Using cache backend SugarCacheAPC, since 940 is less than 1000
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheFile
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemcache
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemcached
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheMemory
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheRedis
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheWincache
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Found cache backend SugarCacheZend
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Found language file: en_us.lang.php
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query:SELECT id, name, symbol, conversion_rate FROM currencies WHERE status = 'Active' and deleted = 0
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query Execution Time:0.00028014183044434
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query:SELECT category, name, value FROM config
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query Execution Time:0.00021195411682129
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query Execution Time:0.00014400482177734
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query Execution Time:0.00013494491577148
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Hook called: ::after_entry_point
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Including Ext hook file for custom/application
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Hook called: ::after_session_start
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] We have an authenticated user id: 1
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Hook called: Users::before_retrieve
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Including module specific hook file for custom/modules/Users
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Retrieve User : SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0
Sat Mar  1 19:58:21 2014 [42337][-none-][DEBUG] Limit Query:SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0 Start: 0 count: 1
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query:SELECT users.* FROM users  WHERE users.id = '1' AND users.deleted=0 LIMIT 0,1
Sat Mar  1 19:58:21 2014 [42337][-none-][INFO] Query Execution Time:0.0002448558807373
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] get_user_array query: SELECT id, first_name, last_name, user_name from users WHERE 1=1 ORDER BY user_name ASC
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT id, first_name, last_name, user_name from users WHERE 1=1 ORDER BY user_name ASC
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00016593933105469
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '1' and u1.deleted=0
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00015091896057129
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '1'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00035881996154785
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] Hook called: Users::after_retrieve
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] Current user is: admin
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] Current user is: admin
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] setting cookie ck_login_id_20 to 1
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] setting cookie ck_login_language_20 to en_us
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] current_language is: en_us
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Found language file: en_us.lang.php
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT count(*) as the_count FROM config WHERE category='info' AND name='sugar_version' AND value = '6.5.15'
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00020503997802734
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT category, name, value FROM config WHERE category = 'license'
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00014710426330566
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT id FROM outbound_email WHERE type = 'system'
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:9.7990036010742E-5
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query:SELECT * FROM outbound_email WHERE id = '94a6de96-23ab-1203-3647-530f41d556ac'
Sat Mar  1 19:58:21 2014 [42337][1][INFO] Query Execution Time:0.00011706352233887
Sat Mar  1 19:58:21 2014 [42337][1][DEBUG] Performing action: action_saveconfig MODULE: Configurator

I am at a loss on what is going on here...  The directories are all good...the file shows up under upload directory... but it appears nothing happens after their...and max debugging turn on and nothing shows up in the log either...

Anyone have any clues what or were I should be looking to get this installed... ?????

Thanks!!!
  • 0
    Hello ,

    This sounds like uncompleted installation.

    1. Check permission and give proper permission to folders according sugarcrm.
    2.  Enable error display from cpanel and check apache error logs that will help you to track out exact problem.

    Regards
  • 0
    Lol...love your response... Guess you did not look at my posting... it is the max logging that sugar can do.  I have set the entire sugar directory to 777 just to make sure it was not a permission problem... but when you have a real answer or some kind of a clue on what is causing this I would love to hear it.

    Thanks bana!
  • 0 in reply to RobbyOliver RobbyOliver
    I have been doing unix for over 25+ years.  I am very good at SQL and Systems.  Everything that is easy and everything that is able to turn debug on I have at max levels to figure out what is going on.  This is a new install of SugarCRM 6.5.15 and I did the upgrade to 6.5.16 figuring that would fix the problem after I have zero success of loading a module.

    This is using lighttpd / php / percona sql 5.6.  Those packages are working perfectly on FreeBSD 10.  It is showing all the missing png files and small code problems in sugarcrm in the log files.  Their are no indications of why the module loader is not working.  Last night I was able to get a different error that I followed out and that did not have any success with fixing the problem either.  It was dealing with zip and remove directories.  The upgrade module works fine.  So why the plugin module will not work and will not show any kind of error in the logs I have no clue on were to look.  Next step is go into sugar code and start logging to a file each function, but that will take way more time than this is worth.  I know sugar can not have this kinds of problems.  Too many people use it.  So their has to be variable that is not set and need to be set.  Is my guess on why the module loader for plugin will not work.

    The problem still remains after upload a plugin to sugar, it goes to a white page with just the 2 line that is always their at the top for the menu selections then blank middle and the bottom showing sql time.

    Anyways, if anyone has a clue or idea I would very much like to hear your comments.  I do not know were to look. 



  • 0 in reply to RobbyOliver RobbyOliver
    Hi RobbyOliver,

    The stack you mentioned in an earlier comment is not a supported environment in terms of the web server and database at a minimum. While you may be able to successfully achieve most functionality within Sugar in this configuration, it is not a guarantee all components will function as expected. With that being said, bana's suggestion about this being a PHP-level error is still the most likely possibility. PHP errors will not log at the Sugar application level so increasing the logging level of Sugar will not assist in debugging those types of issues. For PHP errors, you will need to check your default web server error log, or, if configured, the error_log location as defined in the php.ini file referenced by your web server.

    Kind regards,

    Chris
  • 0 in reply to RobbyOliver RobbyOliver
    Yep that is correct.  Their are no indications of error or problems when calling the module plugin on the web server logs or the php log I have running.  All show nothing and the logging is turn on to extrema levels to give me some idea on what is going on.

    I have managed to get a strange error that I have yet been able to get to the bottom of.  If I take the plugin file and select it then it will give a blank page.  Same if I unzip it and re-zip it with unix zip.  Will still give me a blank page with just sugar headings.  If I unzip it on a win7 box and re-zip it with win7 built-in zip sugar will give the follow error when the module is uploaded:

    The zip file is missing a manifest.php file. Cannot proceed.
     
    On the same win7 box 7zip is used to zip the directory then it goes to the blank screen again with the sugar heading.

    Yes the manifest.php file is in the zip file and in the correct location of the directory's.  I have not figure out why this is yet.  Log files do not give any kind of indication of why.

    I do understand that lighttpd is not supported, but from what I see it appears it's is just using php for sugar and the web server is just doing very simple file sending / receiving.  So I do not see where Apache is needed or required.  I am not seeing any indications in any log files to indicate that their are calls to apache that lighttpd is not doing.  So I do not see why lighttpd will not work with sugar.

    If you know a reason why lighttpd will not work and Apache is required could you please list it so I can move to Apache and get this working.  I need to generate pdf forms from the sugar records.

    Thanks for the info Chris!
  • 0 in reply to RobbyOliver RobbyOliver
    Can you try another module from SugarForge to see if something else will upload? If that works I would suggest reaching out to the Mail Merge developers.

    When you rezipped the module and got this error:
    The zip file is missing a manifest.php file. Cannot proceed
    Make sure to zip the contents so that manifest.php is in the root. Don't zip the folder a level up from there.
  • 0 in reply to RobbyOliver RobbyOliver
    I re-zip the file just like it would unzip.  Yes the manifest.php stayed in the same directory's as it was from the original file.  I have tried other plugin's to see if they would install and they all have the same issues.  So I know it is some kind of problem in php or sugar.  I just do not have a clue on were to look to fix it.

    Thanks for the suggestion eggsurplus!
  • 0 in reply to RobbyOliver RobbyOliver
    Any other modules or themes already installed? If you check the browser console while doing an upload do any javascript errors pop up?

    I understand that everything is set to 777, but I wonder if the file as it gets uploaded to SugarCRM isn't inheriting the permissions correctly. Check /upload/upgrades/module and see if the .zip looks right. Then keep an eye on that directory during install as it will be unzipped in that directory.

  • 0 in reply to RobbyOliver RobbyOliver
    javascript console in both chrome and firefox are not showing errors when upload is going on.  I set everything back from 777 to the original permissions and owner and group.  when I watch uploads it dump the file in the directory as rw r r but I never see it unzip or the unzip is going some place that I am not seeing...

    This is a new install on a 1u on a hp 165 box with 32c opt 62xx amd cpu with freebsd 10 that was loaded up a few weeks ago to test out freebsd 10.  I just loaded sugarcrm to test it out and the only thing I have been able to install was the upgrade for 6.5.15 -> 6.5.16.  Their has be nothing else done to this sugar install beside that one upgrade.  What I call a patch that was applied and I only did that because I thought their might have been some kind of problem in 6.5.15 that was causing a problem not allowing the plugin to install.  Other than that this is as fresh / clean as possible.

    Their has been no modules or themes install because I can not get one module installed.  Since I do not know the interworking of sugar I do not know if it is possible to manually install the plugins.  To see if a forced install would even work by some way of bypassing the web interface.

    Is their any kind of commercial support for sugar? So knowledgeable people can log into a test box and find the problem and fix it?  Just wondering if their is support like that for sugar?

    Thanks eggsurplus!