Comments (21)
That is quite odd.
Can you share the full script?
It looks like there is a loop running here -- are the timestamps really correct? it took almost a minute to fail?
Can you try this:
<?php
$manager = new MongoDB\Driver\Manager("mongodb://localhost:27017");
$command = new MongoDB\Driver\Command(array("ping" => 1));
$result = $manager->executeCommand("test", $command);
var_dump($result, $result->toArray());
from mongo-php-driver.
mongodb.debug
accepts either a directory or stderr
/stdout
as argument.
When running from the command line I usually do:
$ php -dmongodb.debug=stderr myscript.php
Not sure how well that will work on Windows, so can you try:
php.exe -dmongodb.debug=. myscript.php
.
means the current working directory, so it'll create a log file called PHONGO-<timestamp><random>
Can you then post the contents of that file?
Also, is there anything in the mongod.log from when you tried connecting?
from mongo-php-driver.
The output is pretty big :) Cannot upload it here as file.
[2015-09-20T18:51:35+00:00] PHONGO: DEBUG > Connection string: 'mongodb://localhost:27017'
[2015-09-20T18:51:35+00:00] PHONGO: TRACE > ENTRY: php_phongo_make_mongo_client():1810
[2015-09-20T18:51:35+00:00] PHONGO: DEBUG > Creating Manager, phongo-1.0.0beta1[beta] - mongoc-1.1.2, libbson-1.1.3
[2015-09-20T18:51:35+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_init():51
[2015-09-20T18:51:35+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_init():67
[2015-09-20T18:51:35+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_init():97
[2015-09-20T18:51:35+00:00] mongoc: TRACE > EXIT: mongoc_server_description_init():132
[2015-09-20T18:51:35+00:00] cluster: TRACE > ENTRY: mongoc_cluster_init():1367
[2015-09-20T18:51:35+00:00] cluster: TRACE > EXIT: mongoc_cluster_init():1390
[2015-09-20T18:51:35+00:00] client: DEBUG > Using custom stream initiator.
[2015-09-20T18:51:35+00:00] PHONGO: TRACE > EXIT: php_phongo_make_mongo_client():1858
[2015-09-20T18:51:35+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T18:51:35+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T18:51:35+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T18:51:35+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T18:51:35+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T18:51:35+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T18:51:35+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T18:51:35+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T18:51:35+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T18:51:35+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T18:51:35+00:00] PHONGO: TRACE > ENTRY: phongo_stream_initiator():1143
[2015-09-20T18:51:35+00:00] PHONGO: DEBUG > Connecting to 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:35+00:00] PHONGO: DEBUG > Created: RSRC#121 as 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:35+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
[2015-09-20T18:51:35+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T18:51:45+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
[2015-09-20T18:51:45+00:00] PHONGO: DEBUG > Destroying RSRC#121
[2015-09-20T18:51:45+00:00] stream: TRACE > EXIT: mongoc_stream_failed():88
[2015-09-20T18:51:45+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T18:51:45+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T18:51:45+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T18:51:45+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
[2015-09-20T18:51:45+00:00] PHONGO: DEBUG > Connection string: 'mongodb://localhost:27017'
[2015-09-20T18:51:45+00:00] PHONGO: TRACE > ENTRY: php_phongo_make_mongo_client():1810
[2015-09-20T18:51:45+00:00] PHONGO: DEBUG > Creating Manager, phongo-1.0.0beta1[beta] - mongoc-1.1.2, libbson-1.1.3
[2015-09-20T18:51:45+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_init():51
[2015-09-20T18:51:45+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_init():67
[2015-09-20T18:51:45+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_init():97
[2015-09-20T18:51:45+00:00] mongoc: TRACE > EXIT: mongoc_server_description_init():132
[2015-09-20T18:51:45+00:00] cluster: TRACE > ENTRY: mongoc_cluster_init():1367
[2015-09-20T18:51:45+00:00] cluster: TRACE > EXIT: mongoc_cluster_init():1390
[2015-09-20T18:51:45+00:00] client: DEBUG > Using custom stream initiator.
[2015-09-20T18:51:45+00:00] PHONGO: TRACE > EXIT: php_phongo_make_mongo_client():1858
[2015-09-20T18:51:45+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_destroy():88
[2015-09-20T18:51:45+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_destroy():154
[2015-09-20T18:51:45+00:00] mongoc: TRACE > EXIT: mongoc_server_description_destroy():160
[2015-09-20T18:51:45+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_destroy():102
[2015-09-20T18:51:45+00:00] cluster: TRACE > ENTRY: mongoc_cluster_destroy():1413
[2015-09-20T18:51:45+00:00] cluster: TRACE > EXIT: mongoc_cluster_destroy():1423
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T18:51:45+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T18:51:45+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T18:51:45+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T18:51:45+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T18:51:45+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T18:51:45+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T18:51:45+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T18:51:45+00:00] PHONGO: TRACE > ENTRY: phongo_stream_initiator():1143
[2015-09-20T18:51:45+00:00] PHONGO: DEBUG > Connecting to 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:45+00:00] PHONGO: DEBUG > Created: RSRC#126 as 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:45+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
[2015-09-20T18:51:45+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T18:51:55+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
[2015-09-20T18:51:55+00:00] PHONGO: DEBUG > Destroying RSRC#126
[2015-09-20T18:51:56+00:00] stream: TRACE > EXIT: mongoc_stream_failed():88
[2015-09-20T18:51:56+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T18:51:56+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T18:51:56+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T18:51:56+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
[2015-09-20T18:51:56+00:00] PHONGO: DEBUG > Connection string: 'mongodb://localhost:27017'
[2015-09-20T18:51:56+00:00] PHONGO: TRACE > ENTRY: php_phongo_make_mongo_client():1810
[2015-09-20T18:51:56+00:00] PHONGO: DEBUG > Creating Manager, phongo-1.0.0beta1[beta] - mongoc-1.1.2, libbson-1.1.3
[2015-09-20T18:51:56+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_init():51
[2015-09-20T18:51:56+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_init():67
[2015-09-20T18:51:56+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_init():97
[2015-09-20T18:51:56+00:00] mongoc: TRACE > EXIT: mongoc_server_description_init():132
[2015-09-20T18:51:56+00:00] cluster: TRACE > ENTRY: mongoc_cluster_init():1367
[2015-09-20T18:51:56+00:00] cluster: TRACE > EXIT: mongoc_cluster_init():1390
[2015-09-20T18:51:56+00:00] client: DEBUG > Using custom stream initiator.
[2015-09-20T18:51:56+00:00] PHONGO: TRACE > EXIT: php_phongo_make_mongo_client():1858
[2015-09-20T18:51:56+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_destroy():88
[2015-09-20T18:51:56+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_destroy():154
[2015-09-20T18:51:56+00:00] mongoc: TRACE > EXIT: mongoc_server_description_destroy():160
[2015-09-20T18:51:56+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_destroy():102
[2015-09-20T18:51:56+00:00] cluster: TRACE > ENTRY: mongoc_cluster_destroy():1413
[2015-09-20T18:51:56+00:00] cluster: TRACE > EXIT: mongoc_cluster_destroy():1423
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T18:51:56+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T18:51:56+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T18:51:56+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T18:51:56+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T18:51:56+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T18:51:56+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T18:51:56+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T18:51:56+00:00] PHONGO: TRACE > ENTRY: phongo_stream_initiator():1143
[2015-09-20T18:51:56+00:00] PHONGO: DEBUG > Connecting to 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:56+00:00] PHONGO: DEBUG > Created: RSRC#130 as 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:51:56+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
[2015-09-20T18:51:56+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T18:52:06+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
[2015-09-20T18:52:06+00:00] PHONGO: DEBUG > Destroying RSRC#130
[2015-09-20T18:52:07+00:00] stream: TRACE > EXIT: mongoc_stream_failed():88
[2015-09-20T18:52:07+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T18:52:07+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T18:52:07+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T18:52:07+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
[2015-09-20T18:52:07+00:00] PHONGO: DEBUG > Connection string: 'mongodb://localhost:27017'
[2015-09-20T18:52:07+00:00] PHONGO: TRACE > ENTRY: php_phongo_make_mongo_client():1810
[2015-09-20T18:52:07+00:00] PHONGO: DEBUG > Creating Manager, phongo-1.0.0beta1[beta] - mongoc-1.1.2, libbson-1.1.3
[2015-09-20T18:52:07+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_init():51
[2015-09-20T18:52:07+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_init():67
[2015-09-20T18:52:07+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_init():97
[2015-09-20T18:52:07+00:00] mongoc: TRACE > EXIT: mongoc_server_description_init():132
[2015-09-20T18:52:07+00:00] cluster: TRACE > ENTRY: mongoc_cluster_init():1367
[2015-09-20T18:52:07+00:00] cluster: TRACE > EXIT: mongoc_cluster_init():1390
[2015-09-20T18:52:07+00:00] client: DEBUG > Using custom stream initiator.
[2015-09-20T18:52:07+00:00] PHONGO: TRACE > EXIT: php_phongo_make_mongo_client():1858
[2015-09-20T18:52:07+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_destroy():88
[2015-09-20T18:52:07+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_destroy():154
[2015-09-20T18:52:07+00:00] mongoc: TRACE > EXIT: mongoc_server_description_destroy():160
[2015-09-20T18:52:07+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_destroy():102
[2015-09-20T18:52:07+00:00] cluster: TRACE > ENTRY: mongoc_cluster_destroy():1413
[2015-09-20T18:52:07+00:00] cluster: TRACE > EXIT: mongoc_cluster_destroy():1423
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T18:52:07+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T18:52:07+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T18:52:07+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T18:52:07+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T18:52:07+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T18:52:07+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T18:52:07+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T18:52:07+00:00] PHONGO: TRACE > ENTRY: phongo_stream_initiator():1143
[2015-09-20T18:52:07+00:00] PHONGO: DEBUG > Connecting to 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:52:07+00:00] PHONGO: DEBUG > Created: RSRC#133 as 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T18:52:07+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
[2015-09-20T18:52:07+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T18:52:17+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
[2015-09-20T18:52:17+00:00] PHONGO: DEBUG > Destroying RSRC#133
[2015-09-20T18:52:17+00:00] stream: TRACE > EXIT: mongoc_stream_failed():88
[2015-09-20T18:52:17+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T18:52:17+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T18:52:17+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T18:52:17+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T18:52:17+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T18:52:17+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T18:52:17+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T18:52:17+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T18:52:17+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
[2015-09-20T18:52:17+00:00] PHONGO-BSON: TRACE > encoding as-if was stdclass
[2015-09-20T18:52:18+00:00] PHONGO-BSON: TRACE > encoding as-if was stdclass
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T18:52:18+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T18:52:18+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T18:52:18+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T18:52:18+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T18:52:18+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T18:52:18+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T18:52:18+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T18:52:18+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T18:52:18+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T18:52:18+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T18:52:18+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
from mongo-php-driver.
Btw, nothing else in php logs. All i get is a php exception that i catch.
from mongo-php-driver.
My script is actually a huge hybrid(sql+mongo) framework. I created some compatible wrappers with both old and new drivers, because i wanna use php7 on production.
So my framework code works perfect with the legacy driver. I only made the wrappers for the new driver to be able to switch it very easy.
And yes the timestamps are corect :) it hangs for a while. Very strange really. Looks like a timeout somewhere, but not in my script. All the script runs in about <10ms with the legacy driver :)
I get the same hang also in the linux box(debian 7.8) where i built the branch by my own.
the full output for your code is:
[2015-09-20T19:13:00+00:00] PHONGO: DEBUG > Connection string: 'mongodb://localhost:27017'
[2015-09-20T19:13:00+00:00] PHONGO: TRACE > ENTRY: php_phongo_make_mongo_client():1810
[2015-09-20T19:13:00+00:00] PHONGO: DEBUG > Creating Manager, phongo-1.0.0beta1[beta] - mongoc-1.1.2, libbson-1.1.3
[2015-09-20T19:13:00+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_init():51
[2015-09-20T19:13:00+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_init():67
[2015-09-20T19:13:00+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_init():97
[2015-09-20T19:13:00+00:00] mongoc: TRACE > EXIT: mongoc_server_description_init():132
[2015-09-20T19:13:00+00:00] cluster: TRACE > ENTRY: mongoc_cluster_init():1367
[2015-09-20T19:13:00+00:00] cluster: TRACE > EXIT: mongoc_cluster_init():1390
[2015-09-20T19:13:00+00:00] client: DEBUG > Using custom stream initiator.
[2015-09-20T19:13:00+00:00] PHONGO: TRACE > EXIT: php_phongo_make_mongo_client():1858
[2015-09-20T19:13:00+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_new():118
[2015-09-20T19:13:00+00:00] cursor: TRACE > EXIT: _mongoc_cursor_new():314
[2015-09-20T19:13:00+00:00] cursor: TRACE > ENTRY: mongoc_cursor_next():725
[2015-09-20T19:13:00+00:00] cursor: TRACE > TRACE: mongoc_cursor_next():730 cursor_id(0)
[2015-09-20T19:13:00+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_next():761
[2015-09-20T19:13:00+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_query():472
[2015-09-20T19:13:00+00:00] cluster: TRACE > ENTRY: mongoc_cluster_sendv_to_server():2150
[2015-09-20T19:13:00+00:00] cluster: TRACE > EXIT: mongoc_cluster_sendv_to_server():2162
[2015-09-20T19:13:00+00:00] cluster: TRACE > ENTRY: mongoc_cluster_select():1596
[2015-09-20T19:13:00+00:00] cluster: TRACE > ENTRY: _mongoc_cluster_select_by_optype():1449
[2015-09-20T19:13:00+00:00] PHONGO: TRACE > ENTRY: phongo_stream_initiator():1143
[2015-09-20T19:13:00+00:00] PHONGO: DEBUG > Connecting to 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T19:13:00+00:00] PHONGO: DEBUG > Created: RSRC#5 as 'localhost:27017[mongodb://localhost:27017]'
[2015-09-20T19:13:00+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
[2015-09-20T19:13:00+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T19:13:11+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
[2015-09-20T19:13:11+00:00] PHONGO: DEBUG > Destroying RSRC#5
[2015-09-20T19:13:11+00:00] stream: TRACE > EXIT: mongoc_stream_failed():88
[2015-09-20T19:13:11+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_select():430
[2015-09-20T19:13:11+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_select():444
[2015-09-20T19:13:11+00:00] cluster: TRACE > EXIT: _mongoc_cluster_select_by_optype():1460
[2015-09-20T19:13:11+00:00] cursor: TRACE > GOTO: _mongoc_cursor_query():500 failure
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: _mongoc_cursor_query():560
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: _mongoc_cursor_next():816
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: mongoc_cursor_next():750
[2015-09-20T19:13:11+00:00] cursor: TRACE > ENTRY: mongoc_cursor_error():668
[2015-09-20T19:13:11+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_error():702
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: _mongoc_cursor_error():712
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: mongoc_cursor_error():694
[2015-09-20T19:13:11+00:00] cursor: TRACE > ENTRY: mongoc_cursor_destroy():321
[2015-09-20T19:13:11+00:00] cursor: TRACE > ENTRY: _mongoc_cursor_destroy():337
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: _mongoc_cursor_destroy():367
[2015-09-20T19:13:11+00:00] cursor: TRACE > EXIT: mongoc_cursor_destroy():331
PHP Fatal error: Uncaught exception 'MongoDB\Driver\Exception\RuntimeException' with message 'No suitable servers found' in test_mongo2.php:5
Stack trace:
#0 test_mongo2.php(5): MongoDB\Driver\Manager->executeCommand('test', Object(MongoDB\Driver\Command))
#1 {main}
thrown in test_mongo2.php on line 5
Fatal error: Uncaught exception 'MongoDB\Driver\Exception\RuntimeException' with message 'No suitable servers found' in test_mongo2.php:5
Stack trace:
#0 test_mongo2.php(5): MongoDB\Driver\Manager->executeCommand('test', Object(MongoDB\Driver\Command))
#1 {main}
thrown in test_mongo2.php on line 5
[2015-09-20T19:13:11+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_destroy():88
[2015-09-20T19:13:11+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_destroy():154
[2015-09-20T19:13:11+00:00] mongoc: TRACE > EXIT: mongoc_server_description_destroy():160
[2015-09-20T19:13:11+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_destroy():102
[2015-09-20T19:13:11+00:00] cluster: TRACE > ENTRY: mongoc_cluster_destroy():1413
[2015-09-20T19:13:11+00:00] cluster: TRACE > EXIT: mongoc_cluster_destroy():1423
from mongo-php-driver.
These 11 seconds of nothingness are confusing:
[2015-09-20T19:13:00+00:00] PHONGO: TRACE > EXIT: phongo_stream_initiator():1267
[2015-09-20T19:13:11+00:00] stream: TRACE > ENTRY: mongoc_stream_failed():78
The fact setsockopt also fails is weird:
[2015-09-20T19:13:00+00:00] PHONGO: WARNING > setsockopt TCP_NODELAY failed
The weirdest thing is there doesn't appear to be any attempts to write anything (e.g. mongoc_stream_writev() call to write isMaster discovery).
So its never actually able to connect to localhost:27017.
You said you tried this both on Windows and Linux with the same results?
I can't account for those 11seconds.. Before beta#1 that would be the internal SDAM loop retrying, but that was fixed before the beta#1 I believe.
If you could try the current master on linux and see if that changes anything that would be great.
Make sure you git submodule update --init
and use the currently bundled mongoc (there are a few changes we haven't caught up with yet, so using newer version won't work).
from mongo-php-driver.
I cannot compile the master branch in my linux box, because i have php7 in all containers.
I compiled the php7 branch there which seems to be 19 days old.
redownloaded php7 branch, compiled and now it seems that it works on linux.... very strange
here are the results: http://ady.titanfw.net/uploads/mongo_test_linux.txt
But when i run my big sync scripts(which moves like 50MB of text fields from sql to mongo) i get a segmentation fault at the end, but the data syncs fully. So the segmentation fault cames after php script finishes. Maybe is something memory related.
I dont get segmentation fault from your small script.
So it might be a windows related problem ? 1 hour ago i got the same "No suitable servers found". but i changed a lot the config, so maybe it was a really config problem.
But on my windows box I have all extensions installed, and i can change them easily, and I still have the problem.
But anyway i'm happy that i can test it on my php7 install. this was the reason for the beta install.
from mongo-php-driver.
Can you post the backtrace from the segmentation fault? (either if you have to core dump, or can reproduce it).
See instruction for Windows and *nix.
from mongo-php-driver.
Here is the debug from Debian 7.8+php7
http://ady.titanfw.net/uploads/mongo_dbg_linux.txt
from mongo-php-driver.
Ah. Thats likely fixed by #105
Although, that pr is against master, similar check should be done in the PHP7 branch
from mongo-php-driver.
See also https://jira.mongodb.org/browse/PHPC-431
from mongo-php-driver.
Updated from php7 branch, compiled and installed, but i still get that segmentation fault. :)
[2015-09-24T18:14:08+00:00] mongoc: TRACE > ENTRY: mongoc_topology_description_destroy():92
[2015-09-24T18:14:08+00:00] mongoc: TRACE > ENTRY: mongoc_server_description_destroy():158
[2015-09-24T18:14:08+00:00] mongoc: TRACE > EXIT: mongoc_server_description_destroy():164
[2015-09-24T18:14:08+00:00] mongoc: TRACE > EXIT: mongoc_topology_description_destroy():106
[2015-09-24T18:14:08+00:00] stream: TRACE > ENTRY: mongoc_stream_destroy():102
Segmentation fault
The server where I have php7 i use it for production, so i can't do many tests. But I will be able to experiment it on windows when i can get it running atleast partially, on both php7 and php 5.6 :)
from mongo-php-driver.
Can you post the new backtrace?
I find it hard to believe that would be identical as the previous fix verifies base_stream->stream
.
Maybe you ran into a new/different issue exposed as result of this fix.
from mongo-php-driver.
Well, i have changed the branch to php-7.0.0 from master few days ago for php, then recompiled my php and mongo extension, and now, suddenly, i get no segmentation fault...
I'm still testing it. Now it seems to work also via apache(i get full output content everywhere since now). Still testing it, and i'm thinking to update dev env to php7 to be able to test it more further.
I'm still trying to find a workaround for my win php 5.6 "No suitable servers found". And also waiting for a php 7 win build.
Until now it seems to be a really great job on this mongodb driver! :)
from mongo-php-driver.
Thanks! :D
Great that the PHP7 things seem to be working.
1.0.0-beta2 is being released in the next couple of days which upgrades to mongoc-1.2-rc build.
The beta2 is still only compatible with PHP5.[4,5,6], but I'd recommend trying it and see if it resolves the problem -- at the very least the error messaging have improved and should give you a better hint as to why there are no servers found.
from mongo-php-driver.
Updated my windows php 5.6 with latest mongodb beta 2.
And if i connect to 0.0.0.0 or localhost i get:
Fatal error: Uncaught exception 'MongoDB\Driver\Exception\RuntimeException' with message 'No suitable servers found (serverselectiontryonce
set): [connection error calling ismaster on '0.0.0.0:27017']'
If I try to connect to 127.0.0.1 or any other interface IP, PHP crashes:
[fcgid:warn] [pid 2808:tid 1136](OS 109)The pipe has been ended. : [client 127.0.0.1:16536] mod_fcgid: get overlap result error, referer:
[core:error] [pid 2808:tid 1136] [client 127.0.0.1:16536] End of script output before headers: index.php, referer:
from mongo-php-driver.
The ismaster failure on 0.0.0.0:27017 is good (0.0.0.0 is non-routable address, so you can't connect to it, even though you can listen to it).
The crash is very bad.
Can you recreate the backtrace? (see https://bugs.php.net/bugs-generating-backtrace-win32.php)
Also;
Which MongoDB version is this (still 3.0.6?)? - Are there log entries recorded during the time of the crash? (any asserts messages would be very valuable)
from mongo-php-driver.
the same happens to localhost. I wanted to see if the resolve of "localhost" is the problem. I will try to make a backtrace.
PS: My mongodb version is 3.0.6
mod_fcgid: stderr: PHP Fatal error: Uncaught exception 'MongoDB\Driver\Exception\RuntimeException' with message 'No suitable servers found (serverselectiontryonce
set): [connection error calling ismaster on 'localhost:27017']'
from mongo-php-driver.
Did you have any luck creating a backtrace?
from mongo-php-driver.
Same error on php 5.6.12 - php_mongodb-1.0.1-5.6-nts-vc11-x86-1
Change to:
$manager = new MongoDB\Driver\Manager("mongodb://127.0.0.1:27017");
Resolve this issue, Windows 10
from mongo-php-driver.
Resolving this as a dupe of #133, as the same issue appears to have been diagnosed there.
from mongo-php-driver.
Related Issues (20)
- l
- apache stop when I added extension=mongodb.so to php.ini HOT 3
- `selectServer` takes too long on official php base image (connections opened sequentially) HOT 13
- libbson Bug Report : variable ret value type error HOT 8
- No suitable servers found (`serverSelectionTryOnce` set) when rs.initiate with localhost HOT 5
- Extract mongodb-1.6.2.tgz error HOT 5
- Sporadic "Authentication failed" errors HOT 8
- MongoDB PHP Driver 1.15+ increases PHP memory consumption HOT 7
- Error while compiling on macOS HOT 7
- Major slowdown since version 1.17.0 HOT 8
- PHP Warning: PHP Startup: Unable to load dynamic library 'mongodb.so' HOT 2
- MongoDB reporting "AuthenticationAbandoned: Overridden by new authentication session" for a PHP client HOT 14
- Windows build after 1.13.0 HOT 4
- linux general protection fault , sorry for my poor english HOT 1
- PHP refusing to load MongoDB PHP driver on Windows (on one machine but not another) HOT 1
- Can't download desired extension HOT 2
- Unable to install pecl mongodb-1.15.1 in php 8.2 HOT 1
- Bug & Question: How to compile mongodb statically into PHP? HOT 9
- PHPStorm Stub for Manager class has outdated signature HOT 1
- Cannot install with laravel 11 HOT 1
Recommend Projects
-
React
A declarative, efficient, and flexible JavaScript library for building user interfaces.
-
Vue.js
🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.
-
Typescript
TypeScript is a superset of JavaScript that compiles to clean JavaScript output.
-
TensorFlow
An Open Source Machine Learning Framework for Everyone
-
Django
The Web framework for perfectionists with deadlines.
-
Laravel
A PHP framework for web artisans
-
D3
Bring data to life with SVG, Canvas and HTML. 📊📈🎉
-
Recommend Topics
-
javascript
JavaScript (JS) is a lightweight interpreted programming language with first-class functions.
-
web
Some thing interesting about web. New door for the world.
-
server
A server is a program made to process requests and deliver data to clients.
-
Machine learning
Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.
-
Visualization
Some thing interesting about visualization, use data art
-
Game
Some thing interesting about game, make everyone happy.
Recommend Org
-
Facebook
We are working to build community through open source technology. NB: members must have two-factor auth.
-
Microsoft
Open source projects and samples from Microsoft.
-
Google
Google ❤️ Open Source for everyone.
-
Alibaba
Alibaba Open Source for everyone
-
D3
Data-Driven Documents codes.
-
Tencent
China tencent open source team.
from mongo-php-driver.