mesos-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4254
Date Fri, 22 Sep 2017 13:04:58 GMT
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4254/display/redirect?page=changes>

Changes:

[klueska] Added the ability for a plugin command to have an alias in the CLI.

------------------------------------------
[...truncated 22.58 MB...]
I0922 13:04:45.757407  5639 status_update_manager.cpp:203] Recovering status update manager
I0922 13:04:45.757724  5629 containerizer.cpp:648] Recovering containerizer
I0922 13:04:45.758364  5631 http.cpp:1185] HTTP GET for /slave(531)/containers from 172.17.0.3:47859
I0922 13:04:45.758461  5631 http.cpp:976] Authorizing principal 'test-principal' to GET the
'/containers' endpoint
I0922 13:04:45.759286  5635 provisioner.cpp:416] Provisioner recovery complete
I0922 13:04:45.760290  5641 slave.cpp:6322] Finished recovery
I0922 13:04:45.760856  5641 slave.cpp:6504] Querying resource estimator for oversubscribable
resources
I0922 13:04:45.761162  5642 status_update_manager.cpp:177] Pausing sending status updates
I0922 13:04:45.761204  5639 slave.cpp:1002] New master detected at master@172.17.0.3:39964
I0922 13:04:45.761584  5639 slave.cpp:1037] Detecting new master
I0922 13:04:45.761755  5639 slave.cpp:6518] Received oversubscribable resources {} from the
resource estimator
I0922 13:04:45.763180  5637 slave.cpp:1064] Authenticating with master master@172.17.0.3:39964
I0922 13:04:45.763289  5637 slave.cpp:1075] Using default CRAM-MD5 authenticatee
I0922 13:04:45.763653  5642 authenticatee.cpp:121] Creating new client SASL connection
I0922 13:04:45.763873  5608 slave.cpp:869] Agent terminating
I0922 13:04:45.764106  5635 master.cpp:7895] Authenticating slave(531)@172.17.0.3:39964
I0922 13:04:45.764245  5630 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1069)@172.17.0.3:39964
W0922 13:04:45.764741  5633 master.cpp:7922] Failed to authenticate slave(531)@172.17.0.3:39964:
Failed to communicate with authenticatee
I0922 13:04:45.764791  5637 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1069)@172.17.0.3:39964
I0922 13:04:45.772176  5608 master.cpp:1163] Master terminating
[       OK ] SlaveTest.ContainersEndpointNoExecutor (51 ms)
[ RUN      ] SlaveTest.ContainersEndpoint
I0922 13:04:45.778614  5608 cluster.cpp:162] Creating default 'local' authorizer
I0922 13:04:45.781649  5640 master.cpp:445] Master 1b72960f-a393-4f34-bf30-04732e850466 (04176dcb87ea)
started on 172.17.0.3:39964
I0922 13:04:45.781695  5640 master.cpp:447] 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/QCKpyy/credentials" --filter_gpu_resources="true"
--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" --port="5050"
--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="/mesos/mesos-1.5.0/_inst/share/mesos/webui" --work_dir="/tmp/QCKpyy/master"
--zk_session_timeout="10secs"
I0922 13:04:45.782085  5640 master.cpp:497] Master only allowing authenticated frameworks
to register
I0922 13:04:45.782097  5640 master.cpp:511] Master only allowing authenticated agents to register
I0922 13:04:45.782104  5640 master.cpp:524] Master only allowing authenticated HTTP frameworks
to register
I0922 13:04:45.782117  5640 credentials.hpp:37] Loading credentials for authentication from
'/tmp/QCKpyy/credentials'
I0922 13:04:45.782482  5640 master.cpp:569] Using default 'crammd5' authenticator
I0922 13:04:45.782663  5640 http.cpp:1045] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0922 13:04:45.782866  5640 http.cpp:1045] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0922 13:04:45.783018  5640 http.cpp:1045] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0922 13:04:45.783156  5640 master.cpp:649] Authorization enabled
I0922 13:04:45.783439  5631 whitelist_watcher.cpp:77] No whitelist given
I0922 13:04:45.783429  5632 hierarchical.cpp:171] Initialized hierarchical allocator process
I0922 13:04:45.786320  5640 master.cpp:2166] Elected as the leading master!
I0922 13:04:45.786376  5640 master.cpp:1705] Recovering from registrar
I0922 13:04:45.786563  5635 registrar.cpp:347] Recovering registrar
I0922 13:04:45.787370  5635 registrar.cpp:391] Successfully fetched the registry (0B) in 759808ns
I0922 13:04:45.787500  5635 registrar.cpp:495] Applied 1 operations in 35647ns; attempting
to update the registry
I0922 13:04:45.788211  5635 registrar.cpp:552] Successfully updated the registry in 639744ns
I0922 13:04:45.788342  5635 registrar.cpp:424] Successfully recovered registrar
I0922 13:04:45.788729  5631 master.cpp:1804] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0922 13:04:45.788766  5641 hierarchical.cpp:209] Skipping recovery of hierarchical allocator:
nothing to recover
W0922 13:04:45.794594  5608 process.cpp:3194] Attempted to spawn already running process files@172.17.0.3:39964
I0922 13:04:45.795069  5608 cluster.cpp:448] Creating default 'local' authorizer
I0922 13:04:45.798043  5634 slave.cpp:254] Mesos agent started on (532)@172.17.0.3:39964
W0922 13:04:45.798329  5608 process.cpp:3194] Attempted to spawn already running process version@172.17.0.3:39964
I0922 13:04:45.798080  5634 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/SlaveTest_ContainersEndpoint_0fESwz/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/SlaveTest_ContainersEndpoint_0fESwz/credential"
--default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/SlaveTest_ContainersEndpoint_0fESwz/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume"
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs"
--executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/SlaveTest_ContainersEndpoint_0fESwz/fetch"
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/SlaveTest_ContainersEndpoint_0fESwz/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
--launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_build/src" --logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs"
--perf_duration="10secs" --perf_interval="1mins" --port="5051" --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/SlaveTest_ContainersEndpoint_0fESwz" --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/SlaveTest_ContainersEndpoint_uMXC23" --zk_session_timeout="10secs"
I0922 13:04:45.798682  5634 credentials.hpp:86] Loading credential for authentication from
'/tmp/SlaveTest_ContainersEndpoint_0fESwz/credential'
I0922 13:04:45.798949  5634 slave.cpp:287] Agent using credential for: test-principal
I0922 13:04:45.798974  5634 credentials.hpp:37] Loading credentials for authentication from
'/tmp/SlaveTest_ContainersEndpoint_0fESwz/http_credentials'
I0922 13:04:45.799288  5634 http.cpp:1045] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0922 13:04:45.799450  5608 sched.cpp:232] Version: 1.5.0
I0922 13:04:45.799510  5634 http.cpp:1045] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0922 13:04:45.800292  5630 sched.cpp:336] New master detected at master@172.17.0.3:39964
I0922 13:04:45.800509  5630 sched.cpp:407] Authenticating with master master@172.17.0.3:39964
I0922 13:04:45.800534  5630 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0922 13:04:45.800866  5639 authenticatee.cpp:121] Creating new client SASL connection
I0922 13:04:45.801245  5632 master.cpp:7895] Authenticating scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964
I0922 13:04:45.801362  5641 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1070)@172.17.0.3:39964
I0922 13:04:45.801632  5627 authenticator.cpp:98] Creating new server SASL connection
I0922 13:04:45.801615  5634 slave.cpp:585] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0922 13:04:45.801864  5634 slave.cpp:593] Agent attributes: [  ]
I0922 13:04:45.801909  5634 slave.cpp:602] Agent hostname: 04176dcb87ea
I0922 13:04:45.801915  5628 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0922 13:04:45.801944  5628 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0922 13:04:45.802115  5633 authenticator.cpp:204] Received SASL authentication start
I0922 13:04:45.802151  5638 status_update_manager.cpp:177] Pausing sending status updates
I0922 13:04:45.802212  5633 authenticator.cpp:326] Authentication requires more steps
I0922 13:04:45.802317  5633 authenticatee.cpp:259] Received SASL authentication step
I0922 13:04:45.802443  5636 authenticator.cpp:232] Received SASL authentication step
I0922 13:04:45.802474  5636 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '04176dcb87ea' server FQDN: '04176dcb87ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0922 13:04:45.802489  5636 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0922 13:04:45.802531  5636 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0922 13:04:45.802559  5636 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '04176dcb87ea' server FQDN: '04176dcb87ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0922 13:04:45.802578  5636 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0922 13:04:45.802594  5636 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0922 13:04:45.802619  5636 authenticator.cpp:318] Authentication success
I0922 13:04:45.802724  5629 authenticatee.cpp:299] Authentication success
I0922 13:04:45.802868  5631 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1070)@172.17.0.3:39964
I0922 13:04:45.802897  5640 master.cpp:7925] Successfully authenticated principal 'test-principal'
at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964
I0922 13:04:45.803391  5636 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:39964
I0922 13:04:45.803414  5636 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:39964
I0922 13:04:45.803544  5636 sched.cpp:869] Will retry registration in 1.652882845secs if necessary
I0922 13:04:45.803755  5641 master.cpp:2897] Received SUBSCRIBE call for framework 'default'
at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964
I0922 13:04:45.803853  5641 master.cpp:2231] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0922 13:04:45.803889  5628 state.cpp:64] Recovering state from '/tmp/SlaveTest_ContainersEndpoint_uMXC23/meta'
I0922 13:04:45.804193  5628 status_update_manager.cpp:203] Recovering status update manager
I0922 13:04:45.804363  5640 master.cpp:2977] Subscribing framework default with checkpointing
disabled and capabilities [ RESERVATION_REFINEMENT ]
I0922 13:04:45.804551  5639 slave.cpp:6322] Finished recovery
I0922 13:04:45.804965  5640 sched.cpp:759] Framework registered with 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.805017  5640 sched.cpp:773] Scheduler::registered took 24954ns
I0922 13:04:45.805160  5639 slave.cpp:6504] Querying resource estimator for oversubscribable
resources
I0922 13:04:45.805173  5631 hierarchical.cpp:303] Added framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.805395  5638 status_update_manager.cpp:177] Pausing sending status updates
I0922 13:04:45.805420  5639 slave.cpp:1002] New master detected at master@172.17.0.3:39964
I0922 13:04:45.805449  5631 hierarchical.cpp:1943] No allocations performed
I0922 13:04:45.805546  5631 hierarchical.cpp:2033] No inverse offers to send out!
I0922 13:04:45.805598  5639 slave.cpp:1037] Detecting new master
I0922 13:04:45.805624  5631 hierarchical.cpp:1486] Performed allocation for 0 agents in 219777ns
I0922 13:04:45.805714  5639 slave.cpp:6518] Received oversubscribable resources {} from the
resource estimator
I0922 13:04:45.807902  5635 slave.cpp:1064] Authenticating with master master@172.17.0.3:39964
I0922 13:04:45.807968  5635 slave.cpp:1075] Using default CRAM-MD5 authenticatee
I0922 13:04:45.808269  5628 authenticatee.cpp:121] Creating new client SASL connection
I0922 13:04:45.808565  5632 master.cpp:7895] Authenticating slave(532)@172.17.0.3:39964
I0922 13:04:45.808693  5642 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1071)@172.17.0.3:39964
I0922 13:04:45.808985  5630 authenticator.cpp:98] Creating new server SASL connection
I0922 13:04:45.809272  5636 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0922 13:04:45.809309  5636 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0922 13:04:45.809423  5627 authenticator.cpp:204] Received SASL authentication start
I0922 13:04:45.809496  5627 authenticator.cpp:326] Authentication requires more steps
I0922 13:04:45.809607  5640 authenticatee.cpp:259] Received SASL authentication step
I0922 13:04:45.809729  5640 authenticator.cpp:232] Received SASL authentication step
I0922 13:04:45.809767  5640 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '04176dcb87ea' server FQDN: '04176dcb87ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0922 13:04:45.809793  5640 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0922 13:04:45.809846  5640 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0922 13:04:45.809876  5640 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '04176dcb87ea' server FQDN: '04176dcb87ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0922 13:04:45.809891  5640 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0922 13:04:45.809902  5640 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0922 13:04:45.809922  5640 authenticator.cpp:318] Authentication success
I0922 13:04:45.810000  5638 authenticatee.cpp:299] Authentication success
I0922 13:04:45.810101  5633 master.cpp:7925] Successfully authenticated principal 'test-principal'
at slave(532)@172.17.0.3:39964
I0922 13:04:45.810149  5640 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1071)@172.17.0.3:39964
I0922 13:04:45.816189  5638 slave.cpp:1159] Successfully authenticated with master master@172.17.0.3:39964
I0922 13:04:45.816455  5638 slave.cpp:1638] Will retry registration in 3.470132ms if necessary
I0922 13:04:45.816650  5628 master.cpp:5769] Received register agent message from slave(532)@172.17.0.3:39964
(04176dcb87ea)
I0922 13:04:45.816812  5628 master.cpp:3806] Authorizing agent with principal 'test-principal'
I0922 13:04:45.817325  5642 master.cpp:5829] Authorized registration of agent at slave(532)@172.17.0.3:39964
(04176dcb87ea)
I0922 13:04:45.817487  5642 master.cpp:5922] Registering agent at slave(532)@172.17.0.3:39964
(04176dcb87ea) with id 1b72960f-a393-4f34-bf30-04732e850466-S0
I0922 13:04:45.818028  5630 registrar.cpp:495] Applied 1 operations in 57926ns; attempting
to update the registry
I0922 13:04:45.818670  5630 registrar.cpp:552] Successfully updated the registry in 573184ns
I0922 13:04:45.818893  5633 master.cpp:5969] Admitted agent 1b72960f-a393-4f34-bf30-04732e850466-S0
at slave(532)@172.17.0.3:39964 (04176dcb87ea)
I0922 13:04:45.819490  5641 slave.cpp:4978] Received ping from slave-observer(506)@172.17.0.3:39964
I0922 13:04:45.819648  5641 slave.cpp:1205] Registered with master master@172.17.0.3:39964;
given agent ID 1b72960f-a393-4f34-bf30-04732e850466-S0
I0922 13:04:45.819768  5635 status_update_manager.cpp:184] Resuming sending status updates
I0922 13:04:45.819495  5633 master.cpp:6000] Registered agent 1b72960f-a393-4f34-bf30-04732e850466-S0
at slave(532)@172.17.0.3:39964 (04176dcb87ea) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0922 13:04:45.819896  5629 hierarchical.cpp:593] Added agent 1b72960f-a393-4f34-bf30-04732e850466-S0
(04176dcb87ea) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0922 13:04:45.820057  5641 slave.cpp:1225] Checkpointing SlaveInfo to '/tmp/SlaveTest_ContainersEndpoint_uMXC23/meta/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/slave.info'
I0922 13:04:45.820521  5641 slave.cpp:1274] Forwarding total oversubscribed resources {}
I0922 13:04:45.820693  5640 master.cpp:6746] Received update of agent 1b72960f-a393-4f34-bf30-04732e850466-S0
at slave(532)@172.17.0.3:39964 (04176dcb87ea) with total oversubscribed resources {}
I0922 13:04:45.821125  5629 hierarchical.cpp:2033] No inverse offers to send out!
I0922 13:04:45.821177  5629 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.026196ms
I0922 13:04:45.821346  5629 hierarchical.cpp:660] Agent 1b72960f-a393-4f34-bf30-04732e850466-S0
(04176dcb87ea) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0922 13:04:45.821676  5638 master.cpp:7725] Sending 1 offers to framework 1b72960f-a393-4f34-bf30-04732e850466-0000
(default) at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964
I0922 13:04:45.822238  5628 sched.cpp:933] Scheduler::resourceOffers took 102546ns
I0922 13:04:45.824563  5637 master.cpp:9225] Removing offer 1b72960f-a393-4f34-bf30-04732e850466-O0
I0922 13:04:45.824715  5637 master.cpp:4164] Processing ACCEPT call for offers: [ 1b72960f-a393-4f34-bf30-04732e850466-O0
] on agent 1b72960f-a393-4f34-bf30-04732e850466-S0 at slave(532)@172.17.0.3:39964 (04176dcb87ea)
for framework 1b72960f-a393-4f34-bf30-04732e850466-0000 (default) at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964
I0922 13:04:45.824841  5637 master.cpp:3533] Authorizing framework principal 'test-principal'
to launch task 1
I0922 13:04:45.825054  5637 master.cpp:3533] Authorizing framework principal 'test-principal'
to launch task 2
W0922 13:04:45.827006  5633 validation.cpp:1332] Executor 'executor-1' for task '1' uses less
CPUs (None) than the minimum required (0.01). Please update your executor, as this will be
mandatory in future releases.
W0922 13:04:45.827082  5633 validation.cpp:1344] Executor 'executor-1' for task '1' uses less
memory (None) than the minimum required (32MB). Please update your executor, as this will
be mandatory in future releases.
I0922 13:04:45.827441  5633 master.cpp:9971] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 1b72960f-a393-4f34-bf30-04732e850466-S0 at slave(532)@172.17.0.3:39964 (04176dcb87ea)
I0922 13:04:45.827813  5633 master.cpp:4847] Launching task 1 of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
(default) at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 1b72960f-a393-4f34-bf30-04732e850466-S0 at slave(532)@172.17.0.3:39964 (04176dcb87ea)
I0922 13:04:45.828449  5640 slave.cpp:1759] Got assigned task '1' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
W0922 13:04:45.828858  5633 validation.cpp:1332] Executor 'executor-2' for task '2' uses less
CPUs (None) than the minimum required (0.01). Please update your executor, as this will be
mandatory in future releases.
W0922 13:04:45.828891  5633 validation.cpp:1344] Executor 'executor-2' for task '2' uses less
memory (None) than the minimum required (32MB). Please update your executor, as this will
be mandatory in future releases.
I0922 13:04:45.829145  5640 slave.cpp:2027] Authorizing task '1' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.829210  5640 slave.cpp:6821] Authorizing framework principal 'test-principal'
to launch task 1
I0922 13:04:45.829210  5633 master.cpp:9971] Adding task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 1b72960f-a393-4f34-bf30-04732e850466-S0 at slave(532)@172.17.0.3:39964 (04176dcb87ea)
I0922 13:04:45.829515  5633 master.cpp:4847] Launching task 2 of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
(default) at scheduler-63be5c4c-b2cd-4d99-87b9-d74cba37edc3@172.17.0.3:39964 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent 1b72960f-a393-4f34-bf30-04732e850466-S0 at slave(532)@172.17.0.3:39964 (04176dcb87ea)
I0922 13:04:45.829967  5642 slave.cpp:1759] Got assigned task '2' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.830410  5642 slave.cpp:2195] Launching task '1' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.831002  5642 paths.cpp:594] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
to user 'mesos'
I0922 13:04:45.831302  5642 slave.cpp:7283] Launching executor 'executor-1' of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
I0922 13:04:45.831472  5632 hierarchical.cpp:887] Updated allocation of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
on agent 1b72960f-a393-4f34-bf30-04732e850466-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]
I0922 13:04:45.831861  5642 slave.cpp:2886] Launching container 22afcab8-70a6-4e6f-9331-6dcea0bc3b53
for executor 'executor-1' of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.832198  5632 hierarchical.cpp:1161] Recovered ports(allocated: *):[31000-32000];
disk(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated:
cpus(allocated: *):2; mem(allocated: *):1024) on agent 1b72960f-a393-4f34-bf30-04732e850466-S0
from framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.832260  5632 hierarchical.cpp:1207] Framework 1b72960f-a393-4f34-bf30-04732e850466-0000
filtered agent 1b72960f-a393-4f34-bf30-04732e850466-S0 for 5secs
I0922 13:04:45.832299  5642 slave.cpp:2423] Queued task '1' for executor 'executor-1' of framework
1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.832453  5642 slave.cpp:2027] Authorizing task '2' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.832520  5642 slave.cpp:6821] Authorizing framework principal 'test-principal'
to launch task 2
I0922 13:04:45.832993  5642 slave.cpp:953] Successfully attached '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
to virtual path '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/latest'
I0922 13:04:45.833050  5642 slave.cpp:953] Successfully attached '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
to virtual path '/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/latest'
I0922 13:04:45.833099  5642 slave.cpp:953] Successfully attached '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
to virtual path '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-1/runs/22afcab8-70a6-4e6f-9331-6dcea0bc3b53'
I0922 13:04:45.833258  5642 slave.cpp:2195] Launching task '2' for framework 1b72960f-a393-4f34-bf30-04732e850466-0000
I0922 13:04:45.833729  5642 paths.cpp:594] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-2/runs/049e923a-9772-428e-88be-cb85313ed049'
to user 'mesos'
I0922 13:04:45.834009  5642 slave.cpp:7283] Launching executor 'executor-2' of framework 1b72960f-a393-4f34-bf30-04732e850466-0000
with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_uMXC23/slaves/1b72960f-a393-4f34-bf30-04732e850466-S0/frameworks/1b72960f-a393-4f34-bf30-04732e850466-0000/executors/executor-2/runs/049e923a-9772-428e-88be-cb85313ed049'
*** Aborted at 1506085485 (unix time) try "date -d @1506085485" if you are using GNU date
***
PC: @     0x2b6f0ce2382d (unknown)
W0922 13:04:45.834856  5631 process.cpp:3194] Attempted to spawn already running process version@172.17.0.3:39964
I0922 13:04:45.835072  5631 exec.cpp:162] Version: 1.5.0
I0922 13:04:45.835422  5635 exec.cpp:212] Executor started at: executor(135)@172.17.0.3:39964
with pid 5608
*** SIGSEGV (@0xf0) received by PID 5608 (TID 0x2b6f16f53700) from PID 240; stack trace: ***
    @     0x2b6f5e5beaf7 (unknown)
    @     0x2b6f5e5c3449 (unknown)
    @     0x2b6f0cbda330 (unknown)
    @     0x2b6f0ce2382d (unknown)
    @     0x2b6f00c27d5d os::getenv()
    @     0x2b6f095c1a30 mesos::internal::slave::executorEnvironment()
    @     0x2b6f09596cc5 mesos::internal::slave::Slave::launchExecutor()
    @     0x2b6f0959226e mesos::internal::slave::Slave::__run()
    @     0x2b6f095fa79a _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEESB_SE_SH_SM_SQ_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_ENKUlRS9_RSC_RSF_RSK_RSO_PNS_11ProcessBaseEE_clES1D_S1E_S1F_S1G_S1H_S1J_
    @     0x2b6f0966a543 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEE6__callIvJOS1K_EJLm0ELm1ELm2ELm3ELm4ELm5EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
    @     0x2b6f09655ed5 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEEclIIS1K_EvEET0_DpOT_
    @     0x2b6f0963cb71 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS6_13FrameworkInfoERKNS6_12ExecutorInfoERK6OptionINS6_8TaskInfoEERKSN_INS6_13TaskGroupInfoEESG_SJ_SM_SR_SV_EEvRKNS0_3PIDIT_EEMSX_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSE_RSH_RSK_RSP_RST_S2_E_SE_SH_SK_SP_ST_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
    @     0x2b6f0a4ec0b9 std::function<>::operator()()
    @     0x2b6f0a4cd2bb process::ProcessBase::visit()
    @     0x2b6f0a4d95ea process::DispatchEvent::visit()
    @     0x2b6f00bfb3d6 process::ProcessBase::serve()
    @     0x2b6f0a4ca8ad process::ProcessManager::resume()
    @     0x2b6f0a4c6da6 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2b6f0a4d85f4 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2b6f0a4d854b _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2b6f0a4d84e4 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2b6f0c45ba60 (unknown)
    @     0x2b6f0cbd2184 start_thread
    @     0x2b6f0cee5ffd (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1506082021-2815
Untagged: mesos-1506082021-2815:latest
Deleted: sha256:010323e173c1db393b64c8bc88d85f72015c1ac6547290af25daf224092add50
Deleted: sha256:7921b79b2b94a09f806eee61ea15a2e04f982f7714201000aa7bd5b4e0f05f9a
Deleted: sha256:f42ca78ed1765c15ebd5a608a24676f43c178bb4c5bee0eeb3d4347879269d74
Deleted: sha256:a9b793182f814f69d09362a298bfbbd455853e430955c832b3c7ea03e8e68b2d
Deleted: sha256:ea3d1c5f1cc3a5bb641f1b3da8b92f80d080f52eae13a228866d9748aebad352
Deleted: sha256:1df26ff57b190c52c986dbec0786ae1b65ec06a6c30f4f63662e772184e42f14
Deleted: sha256:245753b9d30b2c3603fa157077251cf433f095f1ed505134a68b1ea276ca733a
Deleted: sha256:434e268d0bc66cd36eca29226aaf594437b731a133762ecae26c1e328edd6307
Deleted: sha256:70998ab04e2b1b3258e8ba4089937dfc7d71e82dbff41b0dba53a09cbcb1b133
Deleted: sha256:40210cf0f2a7d954d0f9443698655583ee06a1b679ad0308b3b8ce3c305909f1
Deleted: sha256:b2dba4ff9b9bc61b498a5cf59d59ad2742cbac7514ceb01675b185659413fe13
Deleted: sha256:f1d03085cf6f8f0a865abe044e98e71bd8285d91ed56e0a69bbfd6d7f256010f
Deleted: sha256:a1a4550c761d938488d04b866daaabfb59115fda88f24a42353207b575f25b9e
Deleted: sha256:9efbab4434bc47c44a185b94bf202534d74b4393e097c475ecc254a92c01a8cf
Deleted: sha256:d46e347d5c2019b6462672d6e481c7c28c148a7c3abb03b5f31e9ce76ff41395
Deleted: sha256:df291548980672021de4493983f9671b6c4b92146fb1e5a82d5f8c340f8b35c8
Deleted: sha256:0c2af4d45168d5274609cdb725356f22ae9b968a03d8e6c6f09c4b8d665a4038
Deleted: sha256:141993fc0314386dafd522591064212bc2467a54131478131d5ddca4bc68f235
Deleted: sha256:f6a86b3d0325c64a4ab13dd2f179e584b855ecf762107b176f5ae872825d03db
Deleted: sha256:24a9dbec2dbb7b1e5fa471e8f4f42af4ea226f163d265e887c3d8dc6fd7d3926
Deleted: sha256:0b7d5adc40c73ee724d238ff723e2a399dba960e3f36a3a2b904007c0f1e06e0
Deleted: sha256:83a83c763a74ecf654f6fc35a806444c8e8b66af818b430f15ec651cb091685b
Deleted: sha256:d5182280127c7125074c7defee243b9a6b8ed8c3deecdc66cc7b38064fd8eacf
Deleted: sha256:5dfacc82741c980683b4b5bf5ae85bbcabb3a9a392abd4b7de70deb864a42c02
Deleted: sha256:f084c308d5f093afebd0c22b04fc774c83ab40187c62498d6c337461c14f65cf
Deleted: sha256:bd3da2521734cc7ca04c24a44a6fecfdd7b58a5a4ee520ed1027d51e08d50c42
Deleted: sha256:cf192a3c0d7241a438c451f7f5a632a7ef49950961d0302e0c691187f830501d
Deleted: sha256:08f0ab4ada1ebcfdd6476b049a5e96738249d18c0e0780da3056d1907280d9ec
Build step 'Execute shell' marked build as failure

Mime
View raw message