See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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-eu2)/3399/display/redirect?page=changes>
Changes: [klueska] Added `virtualenv` as a dependency in `getting-started.md`. ------------------------------------------ [...truncated 23.54 MB...] I0321 13:54:52.093582 846 slave.cpp:443] Agent hostname: 682474dca81c I0321 13:54:52.093652 844 status_update_manager.cpp:177] Pausing sending status updates I0321 13:54:52.094054 836 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/meta' I0321 13:54:52.094192 838 status_update_manager.cpp:203] Recovering status update manager I0321 13:54:52.094395 831 slave.cpp:5638] Finished recovery I0321 13:54:52.094815 831 slave.cpp:5820] Querying resource estimator for oversubscribable resources I0321 13:54:52.095023 836 status_update_manager.cpp:177] Pausing sending status updates I0321 13:54:52.095024 831 slave.cpp:821] New master detected at [email protected]:39490 I0321 13:54:52.095064 831 slave.cpp:856] Detecting new master I0321 13:54:52.095129 831 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator I0321 13:54:52.104167 833 slave.cpp:883] Authenticating with master [email protected]:39490 I0321 13:54:52.104218 833 slave.cpp:894] Using default CRAM-MD5 authenticatee I0321 13:54:52.104326 844 authenticatee.cpp:121] Creating new client SASL connection I0321 13:54:52.104571 832 scheduler.cpp:361] Connected with the master at https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.104713 849 master.cpp:7252] Authenticating slave(669)@172.17.0.3:39490 I0321 13:54:52.104790 834 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1256)@172.17.0.3:39490 I0321 13:54:52.104912 837 authenticator.cpp:98] Creating new server SASL connection I0321 13:54:52.105135 828 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0321 13:54:52.105164 828 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0321 13:54:52.105291 839 authenticator.cpp:204] Received SASL authentication start I0321 13:54:52.105339 839 authenticator.cpp:326] Authentication requires more steps I0321 13:54:52.105418 838 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.105537 843 authenticatee.cpp:259] Received SASL authentication step I0321 13:54:52.105651 843 authenticator.cpp:232] Received SASL authentication step I0321 13:54:52.105716 843 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '682474dca81c' server FQDN: '682474dca81c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0321 13:54:52.105728 843 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0321 13:54:52.105741 843 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0321 13:54:52.105765 843 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '682474dca81c' server FQDN: '682474dca81c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0321 13:54:52.105779 843 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0321 13:54:52.105787 843 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0321 13:54:52.105803 843 authenticator.cpp:318] Authentication success I0321 13:54:52.105861 843 authenticatee.cpp:299] Authentication success I0321 13:54:52.105900 843 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(669)@172.17.0.3:39490 I0321 13:54:52.105939 843 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1256)@172.17.0.3:39490 I0321 13:54:52.106175 832 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0321 13:54:52.106256 847 slave.cpp:978] Successfully authenticated with master [email protected]:39490 I0321 13:54:52.106338 847 slave.cpp:1406] Will retry registration in 155911ns if necessary I0321 13:54:52.106492 834 master.cpp:5437] Registering agent at slave(669)@172.17.0.3:39490 (682474dca81c) with id 983238f1-5be4-42d7-8314-adb9a56c8372-S0 I0321 13:54:52.106637 841 registrar.cpp:463] Applied 1 operations in 38422ns; attempting to update the registry I0321 13:54:52.107507 838 slave.cpp:1406] Will retry registration in 7.734769ms if necessary I0321 13:54:52.107548 831 master.cpp:5425] Ignoring register agent message from slave(669)@172.17.0.3:39490 (682474dca81c) as admission is already in progress I0321 13:54:52.107795 841 registrar.cpp:508] Successfully updated the registry in 1.124096ms I0321 13:54:52.108026 829 slave.cpp:4421] Received ping from slave-observer(605)@172.17.0.3:39490 I0321 13:54:52.108055 847 master.cpp:5511] Registered agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0321 13:54:52.108089 829 slave.cpp:1024] Registered with master [email protected]:39490; given agent ID 983238f1-5be4-42d7-8314-adb9a56c8372-S0 I0321 13:54:52.108131 829 fetcher.cpp:94] Clearing fetcher cache I0321 13:54:52.108141 831 hierarchical.cpp:527] Added agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 (682474dca81c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0321 13:54:52.108227 831 hierarchical.cpp:1862] No allocations performed I0321 13:54:52.108237 846 status_update_manager.cpp:184] Resuming sending status updates I0321 13:54:52.108247 831 hierarchical.cpp:1446] Performed allocation for 1 agents in 52994ns I0321 13:54:52.108438 829 slave.cpp:1052] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/meta/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/slave.info' I0321 13:54:52.108686 829 slave.cpp:1090] Forwarding total oversubscribed resources {} I0321 13:54:52.108750 829 master.cpp:6098] Received update of agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) with total oversubscribed resources {} I0321 13:54:52.143649 842 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:54944 I0321 13:54:52.144485 842 master.cpp:2517] Received subscription request for HTTP framework 'default' I0321 13:54:52.144505 842 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0321 13:54:52.144685 841 master.cpp:2632] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I0321 13:54:52.145050 829 hierarchical.cpp:271] Added framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.145210 845 master.hpp:2179] Sending heartbeat to 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.145596 829 hierarchical.cpp:1952] No inverse offers to send out! I0321 13:54:52.145615 829 hierarchical.cpp:1446] Performed allocation for 1 agents in 351340ns I0321 13:54:52.145742 830 master.cpp:7081] Sending 1 offers to framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) I0321 13:54:52.183578 848 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.184237 839 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.184578 830 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.185580 830 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.186389 847 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0321 13:54:52.223655 848 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:54946 I0321 13:54:52.224416 848 master.cpp:3839] Processing ACCEPT call for offers: [ 983238f1-5be4-42d7-8314-adb9a56c8372-O0 ] on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) for framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) I0321 13:54:52.224455 848 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a W0321 13:54:52.225281 841 validation.cpp:1113] Executor 'default' for task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0321 13:54:52.225318 841 validation.cpp:1125] Executor 'default' for task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0321 13:54:52.225517 841 master.cpp:9097] Adding task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.225596 841 master.cpp:4489] Launching task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.225847 829 slave.cpp:1516] Got assigned task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' for framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.226163 829 slave.cpp:1797] Authorizing task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' for framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.226186 829 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a I0321 13:54:52.226194 843 hierarchical.cpp:852] Updated allocation of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] I0321 13:54:52.226569 846 slave.cpp:1984] Launching task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' for framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.227635 846 paths.cpp:547] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000/executors/default/runs/800d6b02-e91c-4c6d-9b5e-acfee9711347' to user 'mesos' I0321 13:54:52.227788 846 slave.cpp:6604] Launching executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000/executors/default/runs/800d6b02-e91c-4c6d-9b5e-acfee9711347' I0321 13:54:52.228032 846 slave.cpp:2198] Queued task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' for executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.228068 846 slave.cpp:774] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000/executors/default/runs/800d6b02-e91c-4c6d-9b5e-acfee9711347' I0321 13:54:52.228911 834 executor.cpp:192] Version: 1.3.0 I0321 13:54:52.240391 839 executor.cpp:401] Connected with the agent I0321 13:54:52.240761 832 executor.cpp:302] Sending SUBSCRIBE call to https://172.17.0.3:39490/slave(669)/api/v1/executor I0321 13:54:52.241323 841 process.cpp:3705] Handling HTTP event for process 'slave(669)' with path: '/slave(669)/api/v1/executor' I0321 13:54:52.279649 845 http.cpp:331] HTTP POST for /slave(669)/api/v1/executor from 172.17.0.3:54948 I0321 13:54:52.279808 845 slave.cpp:3244] Received Subscribe request for HTTP executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.280308 845 slave.cpp:2411] Sending queued task '21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a' to executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (via HTTP) I0321 13:54:52.319572 841 executor.cpp:716] Enqueuing event SUBSCRIBED received from https://172.17.0.3:39490/slave(669)/api/v1/executor I0321 13:54:52.319903 841 executor.cpp:716] Enqueuing event LAUNCH received from https://172.17.0.3:39490/slave(669)/api/v1/executor I0321 13:54:52.321005 839 executor.cpp:302] Sending UPDATE call to https://172.17.0.3:39490/slave(669)/api/v1/executor I0321 13:54:52.321622 844 process.cpp:3705] Handling HTTP event for process 'slave(669)' with path: '/slave(669)/api/v1/executor' I0321 13:54:52.359527 831 http.cpp:331] HTTP POST for /slave(669)/api/v1/executor from 172.17.0.3:54950 I0321 13:54:52.359670 831 slave.cpp:3891] Handling status update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.359953 849 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.359979 849 status_update_manager.cpp:500] Creating StatusUpdate stream for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.360232 849 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 to the agent I0321 13:54:52.360357 828 slave.cpp:4331] Forwarding the update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 to [email protected]:39490 I0321 13:54:52.360486 828 slave.cpp:4225] Status update manager successfully handled status update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.360538 833 master.cpp:6243] Status update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 from agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.360574 833 master.cpp:6311] Forwarding status update TASK_RUNNING (UUID: 2fa6ab3f-2d07-4a0f-ab68-2b19924ebe7e) for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.360844 833 master.cpp:8345] Updating the state of task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0321 13:54:52.361042 849 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from https://172.17.0.3:39490/slave(669)/api/v1/executor I0321 13:54:52.361464 843 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.362211 848 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.3:39490/master/api/v1/scheduler I0321 13:54:52.362730 848 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0321 13:54:52.399693 844 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:54946 I0321 13:54:52.399844 844 master.cpp:7777] Removing framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) I0321 13:54:52.399858 844 master.cpp:3148] Deactivating framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) I0321 13:54:52.399940 844 master.cpp:8345] Updating the state of task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0321 13:54:52.399948 850 hierarchical.cpp:376] Deactivated framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.399971 830 slave.cpp:2738] Asked to shut down framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 by [email protected]:39490 I0321 13:54:52.399996 830 slave.cpp:2763] Shutting down framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.400017 830 slave.cpp:5150] Shutting down executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (via HTTP) I0321 13:54:52.400171 844 master.cpp:8439] Removing task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.400300 844 master.cpp:8468] Removing executor 'default' with resources {} of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.400346 827 hierarchical.cpp:1116] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 from framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.400447 827 hierarchical.cpp:323] Removed framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.400681 849 executor.cpp:716] Enqueuing event SHUTDOWN received from https://172.17.0.3:39490/slave(669)/api/v1/executor E0321 13:54:52.400904 843 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream I0321 13:54:52.401156 850 scheduler.cpp:444] Re-detecting master I0321 13:54:52.401367 850 scheduler.cpp:395] Ignoring disconnection attempt from stale connection I0321 13:54:52.401397 850 scheduler.cpp:395] Ignoring disconnection attempt from stale connection I0321 13:54:52.401469 850 scheduler.cpp:470] New master detected at [email protected]:39490 I0321 13:54:52.402254 850 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0321 13:54:52.403528 848 slave.cpp:4836] Executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 exited with status 0 I0321 13:54:52.403754 848 slave.cpp:4936] Cleaning up executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (via HTTP) W0321 13:54:52.403797 835 master.cpp:6367] Ignoring unknown exited executor 'default' of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 on agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.404124 848 slave.cpp:5024] Cleaning up framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.404134 834 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000/executors/default/runs/800d6b02-e91c-4c6d-9b5e-acfee9711347' for gc 6.99999532467556days in the future I0321 13:54:52.404206 827 status_update_manager.cpp:285] Closing status update streams for framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.404227 827 status_update_manager.cpp:531] Cleaning up status update stream for task 21b3f6b4-bbe1-49da-bd35-3a06b6f2d48a of framework 983238f1-5be4-42d7-8314-adb9a56c8372-0000 I0321 13:54:52.404350 834 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000/executors/default' for gc 6.99999532281185days in the future I0321 13:54:52.404412 834 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_dmUsks/slaves/983238f1-5be4-42d7-8314-adb9a56c8372-S0/frameworks/983238f1-5be4-42d7-8314-adb9a56c8372-0000' for gc 6.99999532187556days in the future I0321 13:54:52.404566 26722 slave.cpp:693] Agent terminating I0321 13:54:52.404661 835 master.cpp:1317] Agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) disconnected I0321 13:54:52.404678 835 master.cpp:3185] Disconnecting agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.404701 835 master.cpp:3204] Deactivating agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 at slave(669)@172.17.0.3:39490 (682474dca81c) I0321 13:54:52.404775 831 hierarchical.cpp:655] Agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 deactivated I0321 13:54:52.405922 26722 master.cpp:1156] Master terminating I0321 13:54:52.406198 832 hierarchical.cpp:560] Removed agent 983238f1-5be4-42d7-8314-adb9a56c8372-S0 W0321 13:54:52.406898 26722 master.hpp:2662] Failed to close HTTP pipe for 983238f1-5be4-42d7-8314-adb9a56c8372-0000 (default) [ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (576 ms) [ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3 *** Aborted at 1490104492 (unix time) try "date -d @1490104492" if you are using GNU date *** I0321 13:54:52.416559 26722 process.cpp:1247] libprocess is initialized on 172.17.0.3:41181 with 24 worker threads PC: @ 0x2b87e156fdbf process::ProcessManager::spawn() *** SIGSEGV (@0x0) received by PID 26722 (TID 0x2b87ef218700) from PID 0; stack trace: *** @ 0x2b87e480a330 (unknown) I0321 13:54:52.417628 26722 cluster.cpp:160] Creating default 'local' authorizer @ 0x2b87e156fdbf process::ProcessManager::spawn() @ 0x2b87e157b2d3 process::spawn() @ 0x2b87e14bf242 process::spawn<>() I0321 13:54:52.418862 853 master.cpp:437] Master 74f2c6d0-59e4-4530-9762-cb69f5035bbc (682474dca81c) started on 172.17.0.3:41181 @ 0x2b87e14bf064 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC2IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_ @ 0x2b87e14825de std::_Function_handler<>::_M_invoke() I0321 13:54:52.418893 853 master.cpp:439] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/l7jDn6/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/l7jDn6/master" --zk_session_timeout="10secs" I0321 13:54:52.419225 853 master.cpp:489] Master only allowing authenticated frameworks to register I0321 13:54:52.419237 853 master.cpp:503] Master only allowing authenticated agents to register I0321 13:54:52.419244 853 master.cpp:516] Master only allowing authenticated HTTP frameworks to register I0321 13:54:52.419250 853 credentials.hpp:37] Loading credentials for authentication from '/tmp/l7jDn6/credentials' I0321 13:54:52.419416 853 master.cpp:561] Using default 'crammd5' authenticator I0321 13:54:52.419476 853 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0321 13:54:52.419536 853 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0321 13:54:52.419581 853 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0321 13:54:52.419620 853 master.cpp:641] Authorization enabled I0321 13:54:52.419704 852 whitelist_watcher.cpp:77] No whitelist given I0321 13:54:52.419767 862 hierarchical.cpp:159] Initialized hierarchical allocator process I0321 13:54:52.420655 867 master.cpp:2165] Elected as the leading master! I0321 13:54:52.420673 867 master.cpp:1704] Recovering from registrar I0321 13:54:52.420764 874 registrar.cpp:331] Recovering registrar I0321 13:54:52.421644 854 registrar.cpp:364] Successfully fetched the registry (0B) in 795904ns I0321 13:54:52.421694 854 registrar.cpp:463] Applied 1 operations in 13265ns; attempting to update the registry I0321 13:54:52.422621 873 registrar.cpp:508] Successfully updated the registry in 872960ns I0321 13:54:52.422684 873 registrar.cpp:394] Successfully recovered registrar I0321 13:54:52.422999 865 master.cpp:1803] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0321 13:54:52.423019 871 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0321 13:54:52.425530 26722 cluster.cpp:446] Creating default 'local' authorizer I0321 13:54:52.426122 873 slave.cpp:210] Mesos agent started on (670)@172.17.0.3:41181 I0321 13:54:52.426421 26722 scheduler.cpp:184] Version: 1.3.0 I0321 13:54:52.426154 873 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_2THqZg" I0321 13:54:52.426455 873 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr/credential' I0321 13:54:52.426573 873 slave.cpp:243] Agent using credential for: test-principal I0321 13:54:52.426591 873 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_XmEfBr/http_credentials' I0321 13:54:52.426687 852 scheduler.cpp:470] New master detected at [email protected]:41181 I0321 13:54:52.426720 873 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0321 13:54:52.426811 873 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0321 13:54:52.427201 873 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0321 13:54:52.427234 873 slave.cpp:438] Agent attributes: [ ] I0321 13:54:52.427239 873 slave.cpp:443] Agent hostname: 682474dca81c I0321 13:54:52.427336 865 status_update_manager.cpp:177] Pausing sending status updates I0321 13:54:52.427523 852 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0321 13:54:52.427688 870 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_2THqZg/meta' I0321 13:54:52.427886 869 status_update_manager.cpp:203] Recovering status update manager I0321 13:54:52.428071 857 slave.cpp:5638] Finished recovery I0321 13:54:52.428434 857 slave.cpp:5820] Querying resource estimator for oversubscribable resources I0321 13:54:52.428530 871 status_update_manager.cpp:177] Pausing sending status updates I0321 13:54:52.428535 874 slave.cpp:821] New master detected at [email protected]:41181 I0321 13:54:52.428617 874 slave.cpp:856] Detecting new master I0321 13:54:52.428661 874 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator @ 0x2b87dffa7e84 std::_Function_handler<>::_M_invoke() @ 0x2b87dffa8829 process::internal::thenf<>() @ 0xbc9d37 process::Future<>::_set<>() @ 0x2b87e1630998 process::network::internal::LibeventSSLSocketImpl::event_callback() @ 0x2b87e162ffd4 process::network::internal::LibeventSSLSocketImpl::event_callback() @ 0x2b87e1657125 bufferevent_run_deferred_callbacks_locked @ 0x2b87e166b387 event_process_active_single_queue @ 0x2b87e1663959 event_process_active @ 0x2b87e16626d4 event_base_loop @ 0x2b87e1601cad process::EventLoop::run() @ 0x2b87e4ac9a60 (unknown) @ 0x2b87e4802184 start_thread @ 0x2b87e5335bed (unknown) make[3]: Leaving directory `/mesos/build' make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped) make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[2]: Leaving directory `/mesos/build' make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1490102444-16074 Untagged: mesos-1490102444-16074:latest Deleted: sha256:fab79bd019819cab55c851876dde1057577088f7b832b2d0063468e397d723f5 Deleted: sha256:8334998ae5128198e65925fed1914473a7921b6e60e0b27d9e917387528679ae Deleted: sha256:610878655d6fcb1483dc41ee0f89322885f7bfa621bdaa1e2336c6ac0a81b125 Deleted: sha256:ffd06a038ac3648d368d317b30077db9d290bd2e6c26f0d5b1f0be8328fcb2e9 Deleted: sha256:c7a3f62af26803feb83477c40037b261bb4ba7904fd9dbabdb09e93b999f7e58 Deleted: sha256:0007b1947e3fabb0a495b0402fd8d64ed7f2ded1694ee09e6091c80e38e2f15f Deleted: sha256:dfe534fdbef52afa5d7bd2860993a51adbd0bad560a5adb3ecc6492bcedc4167 Deleted: sha256:c4a2627d771b72d8632bee597dfdfc9549f52db0951bc9e1fa5e6ddda3def37a Deleted: sha256:6bb5806c55919b7d4edff9f6d43df75b393346ad24863a11a860ead2aa5f56a6 Deleted: sha256:522591ae9077480b66e2cc918273b458de9e90c292efc3b5558d2fce0939df5c Deleted: sha256:af0fa1078ebccff7900b856d28913c273a69fb5d6110331986e4f4b88d928437 Deleted: sha256:f8b159e04e492aa6e2c97f0be5fae8c20263062309fdcc8fb8b936477c1c5dfc Deleted: sha256:24fac8832c164395d2f1e17b5af6b3b5af53c82c9927d921187e70fb06f3a712 Deleted: sha256:e11b12c3b629d5a717c0119507379de6de7cf4013e3a2e97585e17bfa3bc03c6 Deleted: sha256:40547045a9f89af295d9ad727b94a48634c2f168a078d5d894c0688633375d1b Deleted: sha256:145c0c7a363a0e1f14edc30bd3fdd040773f2d3c4fa3d05dfc32301175f99a76 Deleted: sha256:07d3e5e202f5b12d9898e0687a71b0384119b372e22dc7e6955f6d9a6cfca1f3 Deleted: sha256:fa0dcc66fc7d96af5385f856c5b23a28b106777ab6f6a6f70b0a9796b70e2fc9 Deleted: sha256:d1080d42f33318634b3893f7492ae2a3ee047ba133f519ab461f9175ffd994a5 Deleted: sha256:95d25348c8c7f48ad96e1da1bea54e087656691506a722cba8fbd25e6c1faf39 Deleted: sha256:41605b235b29f001978d59806eec10942edbed7be0f6a82d03a37cff471b1cc0 Deleted: sha256:2b8cf7489a1613c4c883917c2bab959ad766882d07282bcf3ab2ca9d2a29667c Deleted: sha256:55bfea12ed74c77821b474f7639565ff96d46a76f4ebfbcd98e1fcd0bc329474 Deleted: sha256:7f6e1c41887f77670c7a4db7195c05ac1d7bc5a694b0d3c4867b59eb35aa23e0 Build step 'Execute shell' marked build as failure
