Benjamin Bannier created MESOS-7114:
---------------------------------------

             Summary: GroupTest.GroupCancelWithDisconnect fails on Mac OS.
                 Key: MESOS-7114
                 URL: https://issues.apache.org/jira/browse/MESOS-7114
             Project: Mesos
          Issue Type: Task
          Components: test
         Environment: OS X
            Reporter: Benjamin Bannier


We saw {{GroupTest.GroupCancelWithDisconnect}} fail on a recent OS X in a SSL 
build in our internal CI recently:

{code}
[ RUN      ] GroupTest.GroupCancelWithDisconnect
I0209 19:22:17.574175 1985630208 zookeeper_test_server.cpp:156] Started 
ZooKeeperTestServer on port 55440
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@726: Client 
environment:zookeeper.version=zookeeper C client 3.4.8
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@730: Client 
environment:host.name=Jenkinss-Mac-mini.local
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@737: Client 
environment:os.name=Darwin
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@738: Client 
environment:os.arch=15.6.0
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@739: Client 
environment:os.version=Darwin Kernel Version 15.6.0: Mon Jan  9 23:07:29 PST 
2017; root:xnu-3248.60.11.2.1~1/RELEASE_X86_64
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@747: Client 
environment:user.name=jenkins
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@755: Client 
environment:user.home=/Users/jenkins
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@log_env@767: Client 
environment:user.dir=/Users/jenkins/workspace/workspace/mesos/Mesos_CI-build/FLAG/SSL/label/mac/mesos/build
2017-02-09 19:22:17,574:84405(0x700000416000):ZOO_INFO@zookeeper_init@800: 
Initiating client connection, host=127.0.0.1:55440 sessionTimeout=10000 
watcher=0x10eba31e0 sessionId=0 sessionPasswd=<null> context=0x7f8edb6dee50 
flags=0
2017-02-09 19:22:17,574:84405(0x700000cb4000):ZOO_INFO@check_events@1728: 
initiated connection to server [127.0.0.1:55440]
2017-02-09 19:22:17,578:84405(0x700000cb4000):ZOO_INFO@check_events@1775: 
session establishment complete on server [127.0.0.1:55440], 
sessionId=0x15a260af8650000, negotiated timeout=10000
I0209 19:22:17.578824 3211264 group.cpp:340] Group process 
(zookeeper-group(44)@10.0.90.182:54133) connected to ZooKeeper
I0209 19:22:17.578876 3211264 group.cpp:830] Syncing group operations: queue 
size (joins, cancels, datas) = (1, 0, 0)
I0209 19:22:17.578893 3211264 group.cpp:418] Trying to create path '/test' in 
ZooKeeper
I0209 19:22:17.582217 2674688 group.cpp:699] Trying to get '/test/0000000000' 
in ZooKeeper
I0209 19:22:17.582960 1985630208 zookeeper_test_server.cpp:116] Shutting down 
ZooKeeperTestServer on port 55440
2017-02-09 
19:22:17,583:84405(0x700000cb4000):ZOO_ERROR@handle_socket_error_msg@1746: 
Socket [127.0.0.1:55440] zk retcode=-4, errno=64(Host is down): failed while 
receiving a server response
I0209 19:22:17.583799 1601536 group.cpp:451] Lost connection to ZooKeeper, 
attempting to reconnect ...
I0209 19:22:17.584373 1601536 group.cpp:656] Trying to remove 
'/test/0000000000' in ZooKeeper
2017-02-09 19:22:17,584:84405(0x700000cb4000):ZOO_INFO@check_events@1728: 
initiated connection to server [127.0.0.1:55440]
2017-02-09 
19:22:17,585:84405(0x700000cb4000):ZOO_ERROR@handle_socket_error_msg@1746: 
Socket [127.0.0.1:55440] zk retcode=-4, errno=64(Host is down): failed while 
receiving a server response
I0209 19:22:17.586333 1985630208 zookeeper_test_server.cpp:156] Started 
ZooKeeperTestServer on port 55440
2017-02-09 19:23:05,168:84405(0x700000cb4000):ZOO_WARN@zookeeper_interest@1570: 
Exceeded deadline by 44249ms
2017-02-09 19:23:05,196:84405(0x700000cb4000):ZOO_INFO@check_events@1728: 
initiated connection to server [127.0.0.1:55440]
2017-02-09 
19:23:05,232:84405(0x700000cb4000):ZOO_ERROR@handle_socket_error_msg@1764: 
Socket [127.0.0.1:55440] zk retcode=-112, errno=70(Stale NFS file handle): 
sessionId=0x15a260af8650000 has expired.
I0209 19:23:05.232564 2138112 group.cpp:830] Syncing group operations: queue 
size (joins, cancels, datas) = (0, 1, 0)
I0209 19:23:05.243890 2138112 group.cpp:656] Trying to remove 
'/test/0000000000' in ZooKeeper
W0209 19:23:05.257310 2138112 group.cpp:494] Timed out waiting to connect to 
ZooKeeper. Forcing ZooKeeper session (sessionId=15a260af8650000) expiration
I0209 19:23:05.258072 2138112 group.cpp:510] ZooKeeper session expired
../../src/tests/group_tests.cpp:183: Failure
Failed to wait 15secs for cancellation
2017-02-09 19:23:05,260:84405(0x70000020a000):ZOO_INFO@zookeeper_close@2543: 
Freeing zookeeper resources for sessionId=0x15a260af8650000

2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@726: Client 
environment:zookeeper.version=zookeeper C client 3.4.8
2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@730: Client 
environment:host.name=Jenkinss-Mac-mini.local
2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@737: Client 
environment:os.name=Darwin
2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@738: Client 
environment:os.arch=15.6.0
2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@739: Client 
environment:os.version=Darwin Kernel Version 15.6.0: Mon Jan  9 23:07:29 PST 
2017; root:xnu-3248.60.11.2.1~1/RELEASE_X86_64
2017-02-09 19:23:05,260:84405(0x70000028d000):ZOO_INFO@log_env@747: Client 
environment:user.name=jenkins
2017-02-09 19:23:05,262:84405(0x70000028d000):ZOO_INFO@log_env@755: Client 
environment:user.home=/Users/jenkins
2017-02-09 19:23:05,262:84405(0x70000028d000):ZOO_INFO@log_env@767: Client 
environment:user.dir=/Users/jenkins/workspace/workspace/mesos/Mesos_CI-build/FLAG/SSL/label/mac/mesos/build
2017-02-09 19:23:05,262:84405(0x70000028d000):ZOO_INFO@zookeeper_init@800: 
Initiating client connection, host=127.0.0.1:55440 sessionTimeout=10000 
watcher=0x10eba31e0 sessionId=0 sessionPasswd=<null> context=0x7f8edb434bf0 
flags=0
2017-02-09 19:23:05,264:84405(0x700000cb4000):ZOO_INFO@check_events@1728: 
initiated connection to server [127.0.0.1:55440]
2017-02-09 19:23:05,269:84405(0x700000cb4000):ZOO_INFO@check_events@1775: 
session establishment complete on server [127.0.0.1:55440], 
sessionId=0x15a260af8710000, negotiated timeout=10000
I0209 19:23:05.271237 1601536 group.cpp:340] Group process 
(zookeeper-group(44)@10.0.90.182:54133) connected to ZooKeeper
I0209 19:23:05.271550 1601536 group.cpp:830] Syncing group operations: queue 
size (joins, cancels, datas) = (0, 1, 0)
I0209 19:23:05.272037 1601536 group.cpp:418] Trying to create path '/test' in 
ZooKeeper
I0209 19:23:05.275660 1601536 group.cpp:656] Trying to remove 
'/test/0000000000' in ZooKeeper
../../src/tests/group_tests.cpp:191: Failure
Value of: membership.get().cancelled().get()
  Actual: false
Expected: true
2017-02-09 19:23:05,289:84405(0x700000310000):ZOO_INFO@zookeeper_close@2526: 
Closing zookeeper sessionId=0x15a260af8710000 to [127.0.0.1:55440]

I0209 19:23:05.291149 1985630208 zookeeper_test_server.cpp:116] Shutting down 
ZooKeeperTestServer on port 55440
[  FAILED  ] GroupTest.GroupCancelWithDisconnect (47724 ms)
{code}



--
This message was sent by Atlassian JIRA
(v6.3.15#6346)

Reply via email to