You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/09/20 02:13:21 UTC

Build failed in Jenkins: Mesos » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2649

See <https://builds.apache.org/job/Mesos/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2649/changes>

Changes:

[josephwu] Removed incorrect CHECK in SSL socket `send()`.

[josephwu] Fixed potential FD double close in the libevent socket.

[josephwu] Added check in FileEncoder's destructor.

[josephwu] Checked correct file descriptor after call to `dup`.

[josephwu] Backported MESOS-5986, MESOS-6104, and MESOS-6152 to 0.27.x.

------------------------------------------
[...truncated 163409 lines...]
I0920 02:12:21.124475  1047 leveldb.cpp:202] Seeked to beginning of db in 1733ns
I0920 02:12:21.124555  1047 leveldb.cpp:271] Iterated through 0 keys in the db in 431ns
I0920 02:12:21.124611  1047 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0920 02:12:21.125077  1072 recover.cpp:447] Starting replica recovery
I0920 02:12:21.125450  1072 recover.cpp:473] Replica is in EMPTY status
I0920 02:12:21.126569  1076 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (14197)@172.17.0.2:41815
I0920 02:12:21.126902  1074 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0920 02:12:21.127318  1069 recover.cpp:564] Updating replica status to STARTING
I0920 02:12:21.128096  1072 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 623668ns
I0920 02:12:21.128268  1072 replica.cpp:320] Persisted replica status to STARTING
I0920 02:12:21.128317  1070 master.cpp:374] Master 0539f8ea-e8ca-4d59-964a-d562e0ed526e (d71b59271d82) started on 172.17.0.2:41815
I0920 02:12:21.128496  1072 recover.cpp:473] Replica is in STARTING status
I0920 02:12:21.128340  1070 master.cpp:376] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/VXdRDQ/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.3/_inst/share/mesos/webui" --work_dir="/tmp/VXdRDQ/master" --zk_session_timeout="10secs"
I0920 02:12:21.128644  1070 master.cpp:423] Master allowing unauthenticated frameworks to register
I0920 02:12:21.128657  1070 master.cpp:426] Master only allowing authenticated slaves to register
I0920 02:12:21.128664  1070 credentials.hpp:35] Loading credentials for authentication from '/tmp/VXdRDQ/credentials'
I0920 02:12:21.128973  1070 master.cpp:466] Using default 'crammd5' authenticator
I0920 02:12:21.129106  1070 master.cpp:535] Using default 'basic' HTTP authenticator
I0920 02:12:21.129235  1070 master.cpp:569] Authorization enabled
I0920 02:12:21.129434  1080 whitelist_watcher.cpp:77] No whitelist given
I0920 02:12:21.129464  1073 hierarchical.cpp:144] Initialized hierarchical allocator process
I0920 02:12:21.129497  1080 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (14199)@172.17.0.2:41815
I0920 02:12:21.129878  1072 recover.cpp:193] Received a recover response from a replica in STARTING status
I0920 02:12:21.130388  1078 recover.cpp:564] Updating replica status to VOTING
I0920 02:12:21.131067  1074 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 436036ns
I0920 02:12:21.131093  1074 replica.cpp:320] Persisted replica status to VOTING
I0920 02:12:21.131239  1074 recover.cpp:578] Successfully joined the Paxos group
I0920 02:12:21.131507  1074 recover.cpp:462] Recover process terminated
I0920 02:12:21.131638  1068 master.cpp:1710] The newly elected leader is master@172.17.0.2:41815 with id 0539f8ea-e8ca-4d59-964a-d562e0ed526e
I0920 02:12:21.131777  1068 master.cpp:1723] Elected as the leading master!
I0920 02:12:21.131803  1068 master.cpp:1468] Recovering from registrar
I0920 02:12:21.132006  1072 registrar.cpp:307] Recovering registrar
I0920 02:12:21.132709  1078 log.cpp:659] Attempting to start the writer
I0920 02:12:21.133918  1068 replica.cpp:493] Replica received implicit promise request from (14200)@172.17.0.2:41815 with proposal 1
I0920 02:12:21.134361  1068 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 415773ns
I0920 02:12:21.134383  1068 replica.cpp:342] Persisted promised to 1
I0920 02:12:21.134860  1069 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0920 02:12:21.135944  1077 replica.cpp:388] Replica received explicit promise request from (14201)@172.17.0.2:41815 for position 0 with proposal 2
I0920 02:12:21.136361  1077 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 358458ns
I0920 02:12:21.136384  1077 replica.cpp:712] Persisted action at 0
I0920 02:12:21.137289  1072 replica.cpp:537] Replica received write request for position 0 from (14202)@172.17.0.2:41815
I0920 02:12:21.137349  1072 leveldb.cpp:436] Reading position from leveldb took 30132ns
I0920 02:12:21.137723  1072 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 328166ns
I0920 02:12:21.137745  1072 replica.cpp:712] Persisted action at 0
I0920 02:12:21.138316  1075 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0920 02:12:21.138689  1075 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 339390ns
I0920 02:12:21.138731  1075 replica.cpp:712] Persisted action at 0
I0920 02:12:21.138818  1075 replica.cpp:697] Replica learned NOP action at position 0
I0920 02:12:21.139711  1075 log.cpp:675] Writer started with ending position 0
I0920 02:12:21.141050  1071 leveldb.cpp:436] Reading position from leveldb took 37526ns
I0920 02:12:21.142069  1068 registrar.cpp:340] Successfully fetched the registry (0B) in 10.018048ms
I0920 02:12:21.142217  1068 registrar.cpp:439] Applied 1 operations in 39501ns; attempting to update the 'registry'
I0920 02:12:21.143023  1068 log.cpp:683] Attempting to append 170 bytes to the log
I0920 02:12:21.143162  1072 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0920 02:12:21.143834  1081 replica.cpp:537] Replica received write request for position 1 from (14203)@172.17.0.2:41815
I0920 02:12:21.144397  1081 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 519537ns
I0920 02:12:21.144426  1081 replica.cpp:712] Persisted action at 1
I0920 02:12:21.145206  1066 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0920 02:12:21.145608  1066 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 373962ns
I0920 02:12:21.145633  1066 replica.cpp:712] Persisted action at 1
I0920 02:12:21.145732  1066 replica.cpp:697] Replica learned APPEND action at position 1
I0920 02:12:21.146724  1071 registrar.cpp:484] Successfully updated the 'registry' in 4.444928ms
I0920 02:12:21.146975  1071 registrar.cpp:370] Successfully recovered registrar
I0920 02:12:21.147099  1072 log.cpp:702] Attempting to truncate the log to 1
I0920 02:12:21.147485  1074 master.cpp:1520] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0920 02:12:21.147517  1067 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0920 02:12:21.147676  1076 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0920 02:12:21.148489  1071 replica.cpp:537] Replica received write request for position 2 from (14204)@172.17.0.2:41815
I0920 02:12:21.148905  1071 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 379812ns
I0920 02:12:21.148926  1071 replica.cpp:712] Persisted action at 2
I0920 02:12:21.149755  1071 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0920 02:12:21.150245  1071 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 462435ns
I0920 02:12:21.150308  1071 leveldb.cpp:399] Deleting ~1 keys from leveldb took 37620ns
I0920 02:12:21.150336  1071 replica.cpp:712] Persisted action at 2
I0920 02:12:21.150365  1071 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0920 02:12:21.158340  1047 scheduler.cpp:154] Version: 0.27.3
I0920 02:12:21.159121  1073 scheduler.cpp:236] New master detected at master@172.17.0.2:41815
I0920 02:12:21.160174  1066 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:41815
I0920 02:12:21.161731  1078 process.cpp:3144] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0920 02:12:21.162297  1077 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55598
I0920 02:12:21.162485  1077 master.cpp:1972] Received subscription request for HTTP framework 'default'
I0920 02:12:21.162540  1077 master.cpp:1749] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0920 02:12:21.162827  1077 master.cpp:2063] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0920 02:12:21.163878  1070 hierarchical.cpp:265] Added framework 0539f8ea-e8ca-4d59-964a-d562e0ed526e-0000
I0920 02:12:21.163976  1070 hierarchical.cpp:1401] No resources available to allocate!
I0920 02:12:21.164018  1070 hierarchical.cpp:1496] No inverse offers to send out!
I0920 02:12:21.164032  1077 master.hpp:1658] Sending heartbeat to 0539f8ea-e8ca-4d59-964a-d562e0ed526e-0000
I0920 02:12:21.164132  1070 hierarchical.cpp:1094] Performed allocation for 0 slaves in 226041ns
I0920 02:12:21.164789  1070 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:41815
I0920 02:12:21.165385  1070 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:41815
I0920 02:12:21.166206  1070 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0920 02:12:21.166286  1078 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:41815
I0920 02:12:21.167565  1071 process.cpp:3144] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0920 02:12:21.167943  1070 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55599
I0920 02:12:21.168118  1070 master.cpp:2717] Processing REQUEST call for framework 0539f8ea-e8ca-4d59-964a-d562e0ed526e-0000 (default)
I0920 02:12:21.168277  1073 hierarchical.cpp:589] Received resource request from framework 0539f8ea-e8ca-4d59-964a-d562e0ed526e-0000
I0920 02:12:21.168656  1047 master.cpp:1025] Master terminating
I0920 02:12:21.169170  1081 hierarchical.cpp:326] Removed framework 0539f8ea-e8ca-4d59-964a-d562e0ed526e-0000
E0920 02:12:21.169816  1072 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (55 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I0920 02:12:21.178308  1047 leveldb.cpp:174] Opened db in 2.699221ms
I0920 02:12:21.179246  1047 leveldb.cpp:181] Compacted db in 903860ns
I0920 02:12:21.179297  1047 leveldb.cpp:196] Created db iterator in 20846ns
I0920 02:12:21.179322  1047 leveldb.cpp:202] Seeked to beginning of db in 1883ns
I0920 02:12:21.179360  1047 leveldb.cpp:271] Iterated through 0 keys in the db in 530ns
I0920 02:12:21.179437  1047 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0920 02:12:21.179886  1079 recover.cpp:447] Starting replica recovery
I0920 02:12:21.181104  1079 recover.cpp:473] Replica is in EMPTY status
I0920 02:12:21.182265  1073 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (14212)@172.17.0.2:41815
I0920 02:12:21.182852  1072 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0920 02:12:21.182868  1069 master.cpp:374] Master 0700ded2-76d4-4e53-95b9-c5516638e38f (d71b59271d82) started on 172.17.0.2:41815
I0920 02:12:21.182888  1069 master.cpp:376] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/kao8Aw/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.3/_inst/share/mesos/webui" --work_dir="/tmp/kao8Aw/master" --zk_session_timeout="10secs"
I0920 02:12:21.183383  1069 master.cpp:423] Master allowing unauthenticated frameworks to register
I0920 02:12:21.183399  1069 master.cpp:426] Master only allowing authenticated slaves to register
I0920 02:12:21.183410  1069 credentials.hpp:35] Loading credentials for authentication from '/tmp/kao8Aw/credentials'
I0920 02:12:21.183607  1073 recover.cpp:564] Updating replica status to STARTING
I0920 02:12:21.183809  1069 master.cpp:466] Using default 'crammd5' authenticator
I0920 02:12:21.183949  1069 master.cpp:535] Using default 'basic' HTTP authenticator
I0920 02:12:21.184095  1069 master.cpp:569] Authorization enabled
I0920 02:12:21.184267  1068 whitelist_watcher.cpp:77] No whitelist given
I0920 02:12:21.184290  1067 hierarchical.cpp:144] Initialized hierarchical allocator process
I0920 02:12:21.185004  1081 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 1.066808ms
I0920 02:12:21.185048  1081 replica.cpp:320] Persisted replica status to STARTING
I0920 02:12:21.185339  1068 recover.cpp:473] Replica is in STARTING status
I0920 02:12:21.186372  1081 master.cpp:1710] The newly elected leader is master@172.17.0.2:41815 with id 0700ded2-76d4-4e53-95b9-c5516638e38f
I0920 02:12:21.186380  1079 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (14214)@172.17.0.2:41815
I0920 02:12:21.186404  1081 master.cpp:1723] Elected as the leading master!
I0920 02:12:21.186444  1081 master.cpp:1468] Recovering from registrar
I0920 02:12:21.186661  1080 registrar.cpp:307] Recovering registrar
I0920 02:12:21.186712  1071 recover.cpp:193] Received a recover response from a replica in STARTING status
I0920 02:12:21.187525  1079 recover.cpp:564] Updating replica status to VOTING
I0920 02:12:21.188179  1077 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 394427ns
I0920 02:12:21.188208  1077 replica.cpp:320] Persisted replica status to VOTING
I0920 02:12:21.188324  1066 recover.cpp:578] Successfully joined the Paxos group
I0920 02:12:21.188486  1066 recover.cpp:462] Recover process terminated
I0920 02:12:21.189093  1079 log.cpp:659] Attempting to start the writer
I0920 02:12:21.190358  1075 replica.cpp:493] Replica received implicit promise request from (14215)@172.17.0.2:41815 with proposal 1
I0920 02:12:21.190701  1075 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 313997ns
I0920 02:12:21.190721  1075 replica.cpp:342] Persisted promised to 1
I0920 02:12:21.191352  1077 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0920 02:12:21.192698  1069 replica.cpp:388] Replica received explicit promise request from (14216)@172.17.0.2:41815 for position 0 with proposal 2
I0920 02:12:21.193161  1069 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 423664ns
I0920 02:12:21.193182  1069 replica.cpp:712] Persisted action at 0
I0920 02:12:21.194274  1078 replica.cpp:537] Replica received write request for position 0 from (14217)@172.17.0.2:41815
I0920 02:12:21.194326  1078 leveldb.cpp:436] Reading position from leveldb took 24283ns
I0920 02:12:21.194728  1078 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 365340ns
I0920 02:12:21.194751  1078 replica.cpp:712] Persisted action at 0
I0920 02:12:21.195317  1076 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0920 02:12:21.195731  1076 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 383427ns
I0920 02:12:21.195754  1076 replica.cpp:712] Persisted action at 0
I0920 02:12:21.195770  1076 replica.cpp:697] Replica learned NOP action at position 0
I0920 02:12:21.196332  1072 log.cpp:675] Writer started with ending position 0
I0920 02:12:21.197311  1077 leveldb.cpp:436] Reading position from leveldb took 26309ns
I0920 02:12:21.198176  1080 registrar.cpp:340] Successfully fetched the registry (0B) in 11.469824ms
I0920 02:12:21.198295  1080 registrar.cpp:439] Applied 1 operations in 32309ns; attempting to update the 'registry'
I0920 02:12:21.199060  1081 log.cpp:683] Attempting to append 170 bytes to the log
I0920 02:12:21.199283  1079 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0920 02:12:21.199895  1075 replica.cpp:537] Replica received write request for position 1 from (14218)@172.17.0.2:41815
I0920 02:12:21.200300  1075 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 372518ns
I0920 02:12:21.200322  1075 replica.cpp:712] Persisted action at 1
I0920 02:12:21.200829  1069 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0920 02:12:21.200984  1069 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 128656ns
I0920 02:12:21.201006  1069 replica.cpp:712] Persisted action at 1
I0920 02:12:21.201021  1069 replica.cpp:697] Replica learned APPEND action at position 1
I0920 02:12:21.202188  1078 registrar.cpp:484] Successfully updated the 'registry' in 3.826944ms
I0920 02:12:21.202380  1078 registrar.cpp:370] Successfully recovered registrar
I0920 02:12:21.202621  1080 log.cpp:702] Attempting to truncate the log to 1
I0920 02:12:21.202838  1073 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0920 02:12:21.202991  1077 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0920 02:12:21.203299  1070 master.cpp:1520] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0920 02:12:21.203788  1069 replica.cpp:537] Replica received write request for position 2 from (14219)@172.17.0.2:41815
I0920 02:12:21.204195  1069 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 370688ns
I0920 02:12:21.204219  1069 replica.cpp:712] Persisted action at 2
I0920 02:12:21.204890  1068 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0920 02:12:21.205446  1068 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 513711ns
I0920 02:12:21.205513  1068 leveldb.cpp:399] Deleting ~1 keys from leveldb took 34953ns
I0920 02:12:21.205543  1068 replica.cpp:712] Persisted action at 2
I0920 02:12:21.205580  1068 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0920 02:12:21.213755  1047 scheduler.cpp:154] Version: 0.27.3
I0920 02:12:21.214421  1075 scheduler.cpp:236] New master detected at master@172.17.0.2:41815
I0920 02:12:21.215414  1068 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:41815
I0920 02:12:21.217087  1075 process.cpp:3144] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0920 02:12:21.217631  1072 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55601
I0920 02:12:21.218003  1072 master.cpp:1972] Received subscription request for HTTP framework 'default'
I0920 02:12:21.218068  1072 master.cpp:1749] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0920 02:12:21.218333  1072 master.cpp:2063] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0920 02:12:21.218732  1075 hierarchical.cpp:265] Added framework 0700ded2-76d4-4e53-95b9-c5516638e38f-0000
I0920 02:12:21.218863  1075 hierarchical.cpp:1401] No resources available to allocate!
I0920 02:12:21.218921  1075 hierarchical.cpp:1496] No inverse offers to send out!
I0920 02:12:21.218924  1077 master.hpp:1658] Sending heartbeat to 0700ded2-76d4-4e53-95b9-c5516638e38f-0000
I0920 02:12:21.218971  1075 hierarchical.cpp:1094] Performed allocation for 0 slaves in 210872ns
I0920 02:12:21.220075  1076 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:41815
I0920 02:12:21.220603  1076 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:41815
I0920 02:12:21.221271  1075 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0920 02:12:21.221326  1076 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:41815
I0920 02:12:21.222939  1081 process.cpp:3144] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0920 02:12:21.223698  1076 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55602
I0920 02:12:21.223947  1076 master.cpp:2717] Processing REQUEST call for framework 0700ded2-76d4-4e53-95b9-c5516638e38f-0000 (default)
I0920 02:12:21.224205  1076 hierarchical.cpp:589] Received resource request from framework 0700ded2-76d4-4e53-95b9-c5516638e38f-0000
I0920 02:12:21.224761  1047 master.cpp:1025] Master terminating
I0920 02:12:21.225124  1071 hierarchical.cpp:326] Removed framework 0700ded2-76d4-4e53-95b9-c5516638e38f-0000
E0920 02:12:21.225826  1074 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (58 ms)
[----------] 22 tests from ContentType/SchedulerTest (4348 ms total)

[----------] Global test environment tear-down
[==========] 969 tests from 124 test cases ran. (353588 ms total)
[  PASSED  ] 967 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] ProvisionerDockerLocalStoreTest.LocalStoreTestWithTar
[  FAILED  ] ProvisionerDockerLocalStoreTest.MetadataManagerInitialization

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.27.3/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.27.3/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.27.3/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.27.3/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1474335563-6402
Untagged: mesos-1474335563-6402:latest
Deleted: sha256:f7412ce896e04a4cc6fb62ada393943d53e2bde4d075ef92eb00bd14c1ce5262
Deleted: sha256:df078694cdbc1f72a2330ffb5f3c8d7e453d6145276660dfebb6d00ecdcdd0de
Deleted: sha256:d73a54dfcaa2c98ebe7f529075d9d02ca83a07784a4079be0caee2a9a2438803
Deleted: sha256:954d48f16b4e832997e03dd976cab1012e491d727f937a0b2deec2e96e1c8093
Deleted: sha256:640e2e58fc26aa2a828d113b534c5463e8c74aa0be1627e9f6a63edad378ab79
Deleted: sha256:fc5c857c4b301ef0b6dfdac73ceb93e65641898b239db8ec06b39d1f8a5f0119
Deleted: sha256:a7807cc310551c0d277140d8f3d5b78db3851f6bd6aa60a0ca0f1077253520bb
Deleted: sha256:2f1149c860b5dfbaa138480c5b8383818868d731c93d807585c3fb2b8d8bd561
Deleted: sha256:92f57adb8ed6eb7530c6a65e1ef2dec6972a254a15f4ae4337bd6f209cfab852
Deleted: sha256:b8a51ca9eeafe9492162d069b47ec6c8ae54b7f2d917964119054d33f457ee98
Deleted: sha256:c8453746fa17aaaf37c752a7e56fdd596aa3d2cb79074ae7dcf3665b532ae3c8
Deleted: sha256:9fdf185b20e8f5ed0fd21c7042da69a631597ae6b11be5bf3dbb278c0a046062
Deleted: sha256:5f08ab08c56a42e3438ea2a135f0a6a977945e0f5139df5ce734af2ee728d5a9
Deleted: sha256:3e270530f70a1c6139d7ab4cce39935e5de0cfc56b50d63a6bc547651d31c760
Deleted: sha256:0d512e5d75a88bad6190f3d1ef7e56e4e463c2ff6e2a96aadfcfc29c157cf48b
Deleted: sha256:6fd176a219409e3a329a59ec548c0ae1b490ccdca236391d6afdf43bade4cd62
Deleted: sha256:f38944edadadf71720b07203c8c568c20a5067412936fcf10f8d0cc60e7d6faf
Deleted: sha256:713cf427cd72066df8e21e6ade3adc3cb24e123487cea1d045dc3baacb2f8940
Deleted: sha256:fba78df63dd0d87c6d9441be204fe45a7e54643ba92bbb6cfeaabfa350750581
Deleted: sha256:9b2d95757a62a521de02673ed0c86d1775011651b2802ac5040bb7d11829238a
Deleted: sha256:451cc428b6fff67b9e68bce9f09634f42c88891f40f3e1a7a4d79f92a458ab74
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2650

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2650/changes>