No suitable servers found - Windows, PHP 5.6 NTS - beta 1

[adisoftbn]

Hello

I'm using new MongoDB\Driver\Manager("mongodb://localhost:27017");
I tested with the beta1 on windows with php 5.6 NTS(official dll build), but also with PHP7 in linux custom build(built by me from php7 branch).

I have the server locally for testing. It works with the old mongo extension on php 5.6.
I tried to enable debug with mongodb.debug but also mongodb.debug_log as in doc, but i get no debug info in logs

I use monogdb 3.0.6.

Any ideas what might be the problem ?

[bjori]

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?

[adisoftbn]

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

[adisoftbn]

Btw, nothing else in php logs. All i get is a php exception that i catch.

[bjori]

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());

[adisoftbn]

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

[bjori]

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).

[adisoftbn]

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.

[bjori]

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.

[adisoftbn]

Here is the debug from Debian 7.8+php7

http://ady.titanfw.net/uploads/mongo_dbg_linux.txt

[bjori]

Ah. Thats likely fixed by #105

Although, that pr is against master, similar check should be done in the PHP7 branch

[bjori]

See also https://jira.mongodb.org/browse/PHPC-431

[adisoftbn]

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 :)

[bjori]

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.

[adisoftbn]

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! :)