ether / etherpad-lite

Etherpad: A modern really-real-time collaborative document editor.
http://docs.etherpad.org/
Apache License 2.0
16.46k stars 2.84k forks source link

"stuck" on "Loading" page #224

Closed markreg closed 12 years ago

markreg commented 12 years ago

Output from the server:

[2011-11-22 16:11:55.605] [INFO] console - Your Etherpad Lite git version is 2db8105 [2011-11-22 16:11:55.607] [INFO] console - Report bugs at https://github.com/Pita/etherpad-lite/issues [2011-11-22 16:11:55.778] [INFO] console - Server is listening at 0.0.0.0:9001 [2011-11-22 16:11:55.780] [INFO] console - info - 'socket.io started' [2011-11-22 16:11:58.478] [INFO] http - 200, GET /p/Y9Z81HxiJm [2011-11-22 16:11:59.555] [INFO] socket.io - handshake authorized '17076206631540154799' [2011-11-22 16:12:09.273] [INFO] http - 200, GET /p/Session [2011-11-22 16:12:09.842] [INFO] socket.io - handshake authorized '8602402112052001713' [2011-11-22 16:12:20.548] [INFO] socket.io - transport end [2011-11-22 16:13:54.303] [INFO] socket.io - transport end [2011-11-22 16:13:54.385] [ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"Error loading script","url":"http://localhost:9001/socket.io/1/jsonp-polling/8602402112052001713?t=1322003628473&i=0","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:8.0) Gecko/20100101 Firefox/8.0"} [2011-11-22 16:13:54.385] [INFO] http - 200, POST /jserror [2011-11-22 16:13:54.391] [INFO] http - 304, GET /p/Session [2011-11-22 16:13:54.497] [INFO] http - 304, GET /static/css/pad.css [2011-11-22 16:13:54.587] [INFO] http - 304, GET /static/custom/pad.css [2011-11-22 16:13:55.764] [INFO] http - 304, GET /static/custom/pad.js [2011-11-22 16:13:55.765] [INFO] http - 304, GET /p/Session [2011-11-22 16:14:06.984] [INFO] http - 304, GET /p/Session [2011-11-22 16:14:06.984] [INFO] http - 304, GET /p/Session [2011-11-22 16:14:06.989] [INFO] http - 200, GET /p/Session [2011-11-22 16:14:07.239] [INFO] http - 200, GET /static/custom/pad.css [2011-11-22 16:14:07.241] [INFO] http - 200, GET /static/custom/pad.js [2011-11-22 16:14:07.326] [INFO] http - 200, GET /p/Session [2011-11-22 16:14:07.491] [INFO] http - 200, GET /static/css/pad.css [2011-11-22 16:14:07.969] [INFO] http - 200, GET /minified/pad.js [2011-11-22 16:14:08.350] [INFO] socket.io - handshake authorized '12814689401664151200' [2011-11-22 16:14:08.352] [INFO] http - 200, GET /static/img/loading.gif [2011-11-22 16:14:08.352] [INFO] http - 200, GET /static/img/leftarrow.png [2011-11-22 16:14:08.354] [INFO] http - 200, GET /static/img/etherpad_lite_icons.png [2011-11-22 16:15:10.870] [INFO] socket.io - handshake authorized '1315621722183686826' [2011-11-22 16:15:26.590] [INFO] socket.io - handshake authorized '18885323151886586089' [2011-11-22 16:15:46.306] [INFO] socket.io - transport end [2011-11-22 16:15:46.892] [INFO] socket.io - handshake authorized '15656086571427261589' [2011-11-22 16:15:57.890] [INFO] socket.io - handshake authorized '1517462598504470842' [2011-11-22 16:16:01.757] [INFO] socket.io - transport end [2011-11-22 16:16:01.892] [INFO] socket.io - handshake authorized '1010530881398101965' [2011-11-22 16:16:12.340] [INFO] socket.io - handshake authorized '1436364354846802906' [2011-11-22 16:16:21.841] [INFO] socket.io - transport end [2011-11-22 16:16:21.891] [INFO] socket.io - handshake authorized '1911975752963537353' [2011-11-22 16:16:22.059] [INFO] socket.io - transport end [2011-11-22 16:16:22.347] [INFO] socket.io - handshake authorized '12068730911951072905' [2011-11-22 16:16:32.591] [INFO] socket.io - handshake authorized '838177011930131707' [2011-11-22 16:16:32.681] [INFO] socket.io - handshake authorized '11060044691781968104' [2011-11-22 16:16:37.059] [INFO] socket.io - transport end [2011-11-22 16:16:37.344] [INFO] socket.io - handshake authorized '20409469851233928104' [2011-11-22 16:16:42.148] [INFO] socket.io - transport end [2011-11-22 16:16:42.344] [INFO] socket.io - handshake authorized '15495542341278541409' [2011-11-22 16:16:42.894] [INFO] socket.io - handshake authorized '21112127631096345562' [2011-11-22 16:16:47.507] [INFO] socket.io - transport end [2011-11-22 16:16:47.596] [INFO] socket.io - handshake authorized '352222138360908464' [2011-11-22 16:16:47.717] [INFO] socket.io - handshake authorized '1254756880525740093' [2011-11-22 16:16:47.723] [INFO] socket.io - handshake authorized '907035159755920289' [2011-11-22 16:16:52.645] [INFO] socket.io - handshake authorized '1404301442703982115' [2011-11-22 16:16:52.651] [INFO] socket.io - handshake authorized '18843313321267050994' [2011-11-22 16:16:57.140] [INFO] socket.io - transport end [2011-11-22 16:16:57.348] [INFO] socket.io - handshake authorized '315609965850451540' [2011-11-22 16:16:57.514] [INFO] socket.io - transport end [2011-11-22 16:16:57.643] [INFO] socket.io - handshake authorized '3833772171929311716' [2011-11-22 16:16:57.895] [INFO] socket.io - handshake authorized '6252445231033992425' [2011-11-22 16:17:02.893] [INFO] socket.io - handshake authorized '918487734314263169' [2011-11-22 16:17:07.592] [INFO] socket.io - transport end [2011-11-22 16:17:07.650] [INFO] socket.io - handshake authorized '7280345971251234204' [2011-11-22 16:17:07.654] [INFO] socket.io - handshake authorized '1580211153794212' [2011-11-22 16:17:07.836] [INFO] socket.io - transport end [2011-11-22 16:17:08.101] [INFO] socket.io - handshake authorized '4582640641110936735' [2011-11-22 16:17:08.102] [INFO] socket.io - handshake authorized '10331474711070142302'

It just stays stuck on "Loading".

markreg commented 12 years ago

It just seems really slow...

JohnMcLear commented 12 years ago

Anything on the client?

markreg commented 12 years ago

I get the main page to create a new pad and once I click on "New Pad" it takes me to the etherpad-lite interface then it says "Loading" on the interface for a long time...after about 8 minutes it loads everything but when I type in the client it doesn't update anything on the server and then the client says it needs to reconnect to the server.

If it helps...I installed etherpad-lite in a slightly non conventional way on a host that has restricted access to yum therefore I had to install each package manually. But installDeps.sh doesn't give me any errors other than:

npm WARN gzip@0.1.0 package.json: bugs['web'] should probably be bugs['url'] npm WARN log4js@0.3.9 package.json: bugs['web'] should probably be bugs['url']

aicm commented 12 years ago

I can confirm this. Having the same issue on a normal install. I did not wait 8 minutes, but I usually have to restart etherpad to make it responsive again.

I'm currently proxying it via apche, but even directly (on 9001) it behaves the same.

markreg commented 12 years ago

Yeah I can't do anything to fix it...tried reinstalling eeverythign from scratch and still the same problem.

phrozen77 commented 12 years ago

I've solved it with setting proxy_buffering off; in the vhost conf (location /) - try and see if it helps

(all assuming you're reverse proxying to nginx)

aicm commented 12 years ago

That's great! I'm glad to hear that. I'll try to implement that setting in my apache config as well, just in case.

However, my issue is there even when accessing etherpad-lite itself on port 90001 (which shouldn't have anything to do with my apache reverse proxy config).

markreg commented 12 years ago

I'm not even using apache in the loop. This is the same problem as aicm with connecting to etherpad-lite directly on port 9001.

I have come to the conclusion that there is something wrong with my socket.io not receiving data from the client of visa-versa after trying out many different socket.io applications with node. It's almost like it's stuck. Unfortunately I'm not getting much help on socket.io's github or google groups.

JohnMcLear commented 12 years ago

Try grabbing a version of etherpad-lite from a few weeks ago, do you have the same problem?

markreg commented 12 years ago

How can I download an older version?

JohnMcLear commented 12 years ago

https://github.com/Pita/etherpad-lite/zipball/1.0

is from August.

-----Original Message----- From: markreg [mailto:reply@reply.github.com] Sent: 25 November 2011 01:12 To: John McLear Subject: Re: [etherpad-lite] "stuck" on "Loading" page (#224)

How can I download an older version?


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-2870519 This email and its attachments may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of the organisation from which this email originated. If you are not the intended recipient of this email and its attachments, you must take no action based upon them, nor must you copy or show them to anyone. Please contact the sender if you believe you have received this email in error. This email was sent by School Email - Safe Webmail and Hosted Email for Schools

markreg commented 12 years ago

It says I need to downgrade my version of node to 0.4.x. Should I do so?

JohnMcLear commented 12 years ago

Yep, worth a shot.

-----Original Message----- From: markreg [mailto:reply@reply.github.com] Sent: 25 November 2011 01:39 To: John McLear Subject: Re: [etherpad-lite] "stuck" on "Loading" page (#224)

It says I need to downgrade my version of node to 0.4.x. Should I do so?


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-2870623 This email and its attachments may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of the organisation from which this email originated. If you are not the intended recipient of this email and its attachments, you must take no action based upon them, nor must you copy or show them to anyone. Please contact the sender if you believe you have received this email in error. This email was sent by School Email - Safe Webmail and Hosted Email for Schools

soul9 commented 12 years ago

same issue here, a commit between now and about two weeks ago causes this issue. I have proxy_buffering set to off in nginx. Last revision that works properly for me is 53bf7dc19dd4217dca6a9b454cdb72256aedcec1 , so the bug was introduced right at the next commit, saying 2e79bd50a3eb6ba6f3cdb5f30ad776f5249e7cc4 : fixed socket.io logging Thanks

aicm commented 12 years ago

Okay, it has to be before fb158d2 because I had this issue then as well.

soul9 commented 12 years ago

please try with revision 53bf7dc that's the last one that worked for me.

aicm commented 12 years ago

Okay, I have 53bf7dc up and running. Now that I read the "fixed: socket.io logging" I think I know what the issue is: Whenever you start etherpad by doing bin/run.sh & and then your ssh connection times out, etherpad freezes. Do you think there's a possibility that this is related to console not having a way to output to a connected "head"?

I ran the latest code by doing bin/run.sh > logme.log & and it hasn't gone freezing on me for 2 days now (with usage).

soul9 commented 12 years ago

uh, should this be an issue with safeRun.sh aswell? because safeRUN.sh does redirect stdout and stderr...I use safeRun.sh and still get the same error.

aicm commented 12 years ago

Wish I had an answer for you. In theory it shouldn't be since it's the script that can be used in a cron.

riseuplabs commented 12 years ago

I have this same issue as well, I am running fine with 2cc7dcb. The proxy_buffering off; nginx tip is a red herring, I have that enabled, but if I update to nodejs 1.7 and the latest npm, and I update to the latest git version (043ceac) things fail as reported in this bug. It also has nothing to do with the run.sh/safeRun.sh.

My logs fill up pretty fast with the repeated:

[WARN] socket.io - client not handshaken 'client should reconnect' [INFO] socket.io - transport end

riseuplabs commented 12 years ago

Some additional information, from startup:

Ensure that all dependencies are up to date... npm WARN gzip@0.1.0 package.json: bugs['web'] should probably be bugs['url'] npm WARN log4js@0.3.9 package.json: bugs['web'] should probably be bugs['url'] async@0.1.15 ./node_modules/async gzip@0.1.0 ./node_modules/gzip log4js@0.3.9 ./node_modules/log4js uglify-js@1.1.1 ./node_modules/uglify-js formidable@1.0.7 ./node_modules/formidable clean-css@0.2.4 ./node_modules/clean-css └── optimist@0.1.9 ueberDB@0.1.3 ./node_modules/ueberDB ├── channels@0.0.2 ├── dirty@0.9.4 └── mysql@0.9.4 socket.io@0.8.7 ./node_modules/socket.io ├── policyfile@0.0.4 ├── redis@0.6.7 └── socket.io-client@0.8.7 express@2.5.0 ./node_modules/express ├── mime@1.2.4 ├── mkdirp@0.0.7 ├── qs@0.4.0 └── connect@1.7.3 joose@3.50.0 ./node_modules/joose ├── temp@0.2.0 ├── optimist@0.2.8 (wordwrap@0.0.2) └── detective@0.0.3 Ensure jQuery is downloaded and up to date... [: 57: =: unexpected operator Clear minfified cache... ensure custom css/js files are created... start... [2011-11-25 10:10:25.447] [INFO] console - ESC[39mYour Etherpad Lite git version is 043ceac

riseuplabs commented 12 years ago

I've just confirmed, 53bf7dc does work, and 2e79bd5 is where the issue occurs.

markreg commented 12 years ago

I get these errors when I run sh installDeps.sh and sh run.sh:

npm WARN log4js@0.3.9 package.json: bugs['web'] should probably be bugs['url'] npm WARN gzip@0.1.0 package.json: bugs['web'] should probably be bugs['url']

JohnMcLear commented 12 years ago

That's not an error, that's a warning. There is already an open issue for this.

-----Original Message----- From: markreg [mailto:reply@reply.github.com] Sent: 25 November 2011 18:49 To: John McLear Subject: Re: [etherpad-lite] "stuck" on "Loading" page (#224)

I get these errors when I run sh installDeps.sh:

npm WARN log4js@0.3.9 package.json: bugs['web'] should probably be bugs['url'] npm WARN gzip@0.1.0 package.json: bugs['web'] should probably be bugs['url']


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-2877168 This email and its attachments may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of the organisation from which this email originated. If you are not the intended recipient of this email and its attachments, you must take no action based upon them, nor must you copy or show them to anyone. Please contact the sender if you believe you have received this email in error. This email was sent by School Email - Safe Webmail and Hosted Email for Schools

markreg commented 12 years ago

Wow, problem seems to be solved with riseuplab's latest etherpad-lite build.

On a side note is there anything that I can do to increase the update speed on all of the other clients' windows?

riseuplabs commented 12 years ago

Wow, thanks for the quick resolution on this!

markreg commented 12 years ago

This is beautiful. Thank you so much riseuplabs! :D

markreg commented 12 years ago

I know that this probably isn't the right place to reference this but I forked a repository on a different project by wesbos and it is having similar socket.io problems that etherpad-lite was incurring.

https://github.com/markreg/websocket-canvas-draw

Please take a look and let's see if we can fix the issue.

markreg commented 12 years ago

@riseuplabs

I get this warning message when I open a new pad:

[2011-11-25 12:29:33.649] [WARN] message - Dropped message, unknown Message Type COLLABROOM

Pita commented 12 years ago

I closed this

Frankstar commented 12 years ago

i have the issue with the current master and latest node

Frankstar commented 12 years ago

but have this issues too:

[ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"isAndroid is not defined","url":"http://localhost:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}

ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"$(\"#colorpicker\").farbtastic is not a function","url":"http://localhost:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}

[ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"chat is undefined","url":"http://localhost:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}

JohnMcLear commented 12 years ago

When did you last do a pull?

-----Original Message----- From: Frankstar [mailto:reply@reply.github.com] Sent: 22 January 2012 15:11 To: John McLear Subject: Re: [etherpad-lite] "stuck" on "Loading" page (#224)

but have this issues too:

[ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"isAndroid is not defined","url":"http://frankstar.at:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}

ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"$(\"#colorpicker\").farbtastic is not a function","url":"http://frankstar.at:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}

[ERROR] console - CLIENT SIDE JAVASCRIPT ERROR: {"msg":"chat is undefined","url":"http://frankstar.at:9001/minified/pad.js","linenumber":1,"userAgent":"Mozilla/5.0 (Windows NT 6.1; WOW64; rv:9.0.1) Gecko/20100101 Firefox/9.0.1"}


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-3603484 This email and its attachments may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of the organisation from which this email originated. If you are not the intended recipient of this email and its attachments, you must take no action based upon them, nor must you copy or show them to anyone. Please contact the sender if you believe you have received this email in error. This email was sent by School Email - Safe Webmail and Hosted Email for Schools

Pita commented 12 years ago

@aicm Thats fixed already

Frankstar commented 12 years ago

commit 04d48e859225af11709a00bff29305a9bdf9c977 Author: John McLear john@mclear.co.uk Date: Sun Jan 22 16:29:51 2012 +0000

Added a getting started developing Etherpad Lite video to readme.md..

commit ca68196c32b80a20402a8dbd0ec08d101f5d7c7a Author: John McLear john@mclear.co.uk Date: Sun Jan 22 16:24:06 2012 +0000

Added a getting started developing Etherpad Lite video to readme.md

commit cf4715376960b05fced4fa8e8e73e3e490591260 Merge: cece2c8 165f269 Author: Peter 'Pita' Martischka petermartischka@googlemail.com Date: Sun Jan 22 15:25:50 2012 +0100

doesnt work,

Output console: npm WARN gzip@0.1.0 package.json: bugs['web'] should probably be bugs['url'] npm WARN log4js@0.3.9 package.json: bugs['web'] should probably be bugs['url'] npm WARN prefer global jshint@0.5.7 should be installed with -g

maybe this are the problems ?

also the Errors from above are still showing.

Frankstar commented 12 years ago

weird, now it works .... something is strange here ...

Pita commented 12 years ago

You might just had a bad browser cache

On 22 January 2012 17:54, Frankstar reply@reply.github.com wrote:

weird, now it works .... something is strange here ...


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-3604096

mitfik commented 12 years ago

I've got the same problem right now with latest version.

When I try to get access to etherpad throught nginx it stuck on Loading When I add port :9001 to domain it load without problem.

Any suggestion what could be a problem ?

Edit: I figure out that the problem was that I didn't use https when I add cert to nginx all work fine. Why it does not work without cert ?

JohnMcLear commented 12 years ago

Latest stable or develop?

Robert Mitwicki reply@reply.github.com wrote:

I've got the same problem right now with latest version.

When I try to get access to etherpad throught nginx it stuck on Loading When I add port :9001 to domain it load without problem.

Any suggestion what could be a problem ?


Reply to this email directly or view it on GitHub: https://github.com/Pita/etherpad-lite/issues/224#issuecomment-5538098 This email and its attachments may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of the organisation from which this email originated. If you are not the intended recipient of this email and its attachments, you must take no action based upon them, nor must you copy or show them to anyone. Please contact the sender if you believe you have received this email in error. This email was sent by School Email - Safe Webmail and Hosted Email for Schools

mitfik commented 12 years ago

latest develop (master branch)

JohnMcLear commented 12 years ago

Pretty sure this is a new issue. I noticed this occur on beta.etherpad.org yesterday too. The develop branch is unstable. If you can catch the full stack trace that shows the error on the server that would be useful

ferrix commented 11 years ago

I noticed that an unrotated logfile had bloated and that rendered node slow.

JohnMcLear commented 11 years ago

@ferrix Ah, that is possible. I think the Etherpad init script does log rotation on restart.

Also https://github.com/ether/etherpad-lite/issues/253

As far as I can tell because we use log4js we should have log rotation so you shouldn't have this problem on newer versions of etherpad.

marcelklehr commented 11 years ago

Oh boy, if you need a rotating log use log4js.. https://github.com/nomiddlename/log4js-node/blob/master/examples/log-rolling.js#L5

ferrix commented 11 years ago

I did a pull to a more recent version so the problem should be gone.

brauliobo commented 10 years ago

I also feel this slowness... It takes a lot of time for a pad to load. I'm using the version 1.3.0

JohnMcLear commented 10 years ago

@brauliobo Did you find a cause? Have you tried pulling the latest develop?

brauliobo commented 10 years ago

@JohnMcLear hello john. No, I haven't. We initially used develop branch at pad.eita.org.br, but now we downgraded to 1.3.0.

I currently live on the coutryside of Brazil and have a slow connection, less than 1mb/s. But etherpad-lite takes much more time than usual pages...

JohnMcLear commented 10 years ago

Sorry but we'd need more info.

pad.eita.org.br pads work fine for me, it's very fast.

Can you provide benchmark or stats or so?

brauliobo commented 10 years ago

@JohnMcLear Ok, john, I'll try to debug more on developers tools