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 2017/05/31 21:54:56 UTC

Build failed in Jenkins: Mesos-Reviewbot #18227

See <https://builds.apache.org/job/Mesos-Reviewbot/18227/display/redirect>

------------------------------------------
[...truncated 11.52 MB...]
I0531 21:54:50.513924  4661 sched.cpp:2021] Asked to stop the driver
I0531 21:54:50.514026  4685 sched.cpp:1203] Stopping framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.514320  4681 master.cpp:7926] Processing TEARDOWN call for framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 (default) at scheduler-83de4454-7c69-4dc8-9e47-3beed2a8d113@172.17.0.2:44706
I0531 21:54:50.514367  4681 master.cpp:7938] Removing framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 (default) at scheduler-83de4454-7c69-4dc8-9e47-3beed2a8d113@172.17.0.2:44706
I0531 21:54:50.514405  4681 master.cpp:3157] Deactivating framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 (default) at scheduler-83de4454-7c69-4dc8-9e47-3beed2a8d113@172.17.0.2:44706
I0531 21:54:50.514677  4682 hierarchical.cpp:393] Deactivated framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.514725  4681 master.cpp:8506] Updating the state of task 1 of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0531 21:54:50.514803  4686 slave.cpp:3082] Asked to shut down framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 by master@172.17.0.2:44706
I0531 21:54:50.514892  4686 slave.cpp:3107] Shutting down framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.514966  4686 slave.cpp:5546] Shutting down executor 'default' of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 at executor(74)@172.17.0.2:44706
I0531 21:54:50.515604  4681 master.cpp:8600] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 on agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.515974  4681 master.cpp:8629] Removing executor 'default' with resources {} of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 on agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.516077  4694 hierarchical.cpp:1133] 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 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 from framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.516254  4692 exec.cpp:435] Executor asked to shutdown
I0531 21:54:50.516336  4692 exec.cpp:450] Executor::shutdown took 46878ns
I0531 21:54:50.516701  4685 slave.cpp:4851] Got exited event for executor(74)@172.17.0.2:44706
I0531 21:54:50.516865  4684 hierarchical.cpp:344] Removed framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.516989  4688 slave.cpp:5232] Executor 'default' of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 exited with status 0
I0531 21:54:50.517201  4688 slave.cpp:5332] Cleaning up executor 'default' of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 at executor(74)@172.17.0.2:44706
W0531 21:54:50.517452  4690 master.cpp:6556] Ignoring unknown exited executor 'default' of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000 on agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.517560  4689 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Q66glD/slaves/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0/frameworks/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000/executors/default/runs/7d5a81c0-6feb-4983-a9bd-7191fca7b7ad' for gc 6.99999401162074days in the future
I0531 21:54:50.517714  4688 slave.cpp:5420] Cleaning up framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.517781  4689 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Q66glD/slaves/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0/frameworks/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000/executors/default' for gc 6.99999400863407days in the future
I0531 21:54:50.518055  4688 slave.cpp:801] Agent terminating
I0531 21:54:50.518050  4694 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Q66glD/slaves/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0/frameworks/55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000' for gc 6.99999400651556days in the future
I0531 21:54:50.518216  4684 status_update_manager.cpp:285] Closing status update streams for framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.518285  4684 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-0000
I0531 21:54:50.518328  4688 master.cpp:1313] Agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91) disconnected
I0531 21:54:50.518354  4688 master.cpp:3194] Disconnecting agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.518424  4688 master.cpp:3213] Deactivating agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 at slave(201)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.518604  4695 hierarchical.cpp:672] Agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0 deactivated
I0531 21:54:50.521288  4661 master.cpp:1155] Master terminating
I0531 21:54:50.521875  4688 hierarchical.cpp:577] Removed agent 55e4ec50-b4aa-4a69-8209-d7e40a7f0a97-S0
[       OK ] MasterTest.FrameworkMessage (73 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0531 21:54:50.527858  4661 cluster.cpp:162] Creating default 'local' authorizer
I0531 21:54:50.530678  4689 master.cpp:436] Master 87984e3f-86f9-4870-8e02-a5fb4bea627c (f52a71e21c91) started on 172.17.0.2:44706
I0531 21:54:50.530722  4689 master.cpp:438] 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/WOvX19/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" --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.4.0/_inst/share/mesos/webui" --work_dir="/tmp/WOvX19/master" --zk_session_timeout="10secs"
I0531 21:54:50.531154  4689 master.cpp:488] Master only allowing authenticated frameworks to register
I0531 21:54:50.531170  4689 master.cpp:502] Master only allowing authenticated agents to register
I0531 21:54:50.531178  4689 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0531 21:54:50.531188  4689 credentials.hpp:37] Loading credentials for authentication from '/tmp/WOvX19/credentials'
I0531 21:54:50.531532  4689 master.cpp:560] Using default 'crammd5' authenticator
I0531 21:54:50.531672  4689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0531 21:54:50.531862  4689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0531 21:54:50.532104  4689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0531 21:54:50.532366  4689 master.cpp:640] Authorization enabled
I0531 21:54:50.532573  4691 hierarchical.cpp:165] Initialized hierarchical allocator process
I0531 21:54:50.532608  4682 whitelist_watcher.cpp:77] No whitelist given
I0531 21:54:50.535200  4685 master.cpp:2158] Elected as the leading master!
I0531 21:54:50.535245  4685 master.cpp:1697] Recovering from registrar
I0531 21:54:50.535434  4688 registrar.cpp:345] Recovering registrar
I0531 21:54:50.536100  4684 registrar.cpp:389] Successfully fetched the registry (0B) in 614912ns
I0531 21:54:50.536221  4684 registrar.cpp:493] Applied 1 operations in 29171ns; attempting to update the registry
I0531 21:54:50.536845  4684 registrar.cpp:550] Successfully updated the registry in 558080ns
I0531 21:54:50.536939  4684 registrar.cpp:422] Successfully recovered registrar
I0531 21:54:50.537333  4688 master.cpp:1796] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0531 21:54:50.537345  4681 hierarchical.cpp:204] Skipping recovery of hierarchical allocator: nothing to recover
I0531 21:54:50.541376  4661 cluster.cpp:448] Creating default 'local' authorizer
I0531 21:54:50.542793  4684 slave.cpp:232] Mesos agent started on (202)@172.17.0.2:44706
I0531 21:54:50.542816  4684 slave.cpp:233] 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/MasterTest_MultipleExecutors_qLcLDV/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_qLcLDV/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/MasterTest_MultipleExecutors_qLcLDV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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/MasterTest_MultipleExecutors_qLcLDV" --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/MasterTest_MultipleExecutors_bFVQPx"
I0531 21:54:50.543242  4684 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_qLcLDV/credential'
I0531 21:54:50.543467  4684 slave.cpp:265] Agent using credential for: test-principal
I0531 21:54:50.543503  4684 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_qLcLDV/http_credentials'
I0531 21:54:50.543824  4684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0531 21:54:50.544044  4684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0531 21:54:50.544334  4661 sched.cpp:232] Version: 1.4.0
I0531 21:54:50.544916  4685 sched.cpp:336] New master detected at master@172.17.0.2:44706
I0531 21:54:50.545006  4685 sched.cpp:407] Authenticating with master master@172.17.0.2:44706
I0531 21:54:50.545028  4685 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0531 21:54:50.545364  4693 authenticatee.cpp:121] Creating new client SASL connection
I0531 21:54:50.545516  4684 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0531 21:54:50.545620  4684 slave.cpp:544] Agent attributes: [  ]
I0531 21:54:50.545634  4684 slave.cpp:549] Agent hostname: f52a71e21c91
I0531 21:54:50.545648  4689 master.cpp:7421] Authenticating scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706
I0531 21:54:50.545776  4687 status_update_manager.cpp:177] Pausing sending status updates
I0531 21:54:50.545866  4690 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(436)@172.17.0.2:44706
I0531 21:54:50.546392  4686 authenticator.cpp:98] Creating new server SASL connection
I0531 21:54:50.546725  4686 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0531 21:54:50.546761  4686 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0531 21:54:50.547009  4693 authenticator.cpp:204] Received SASL authentication start
I0531 21:54:50.547147  4693 authenticator.cpp:326] Authentication requires more steps
I0531 21:54:50.547380  4688 authenticatee.cpp:259] Received SASL authentication step
I0531 21:54:50.547600  4693 authenticator.cpp:232] Received SASL authentication step
I0531 21:54:50.547648  4693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f52a71e21c91' server FQDN: 'f52a71e21c91' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0531 21:54:50.547672  4693 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0531 21:54:50.547721  4693 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0531 21:54:50.547755  4693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f52a71e21c91' server FQDN: 'f52a71e21c91' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0531 21:54:50.547772  4693 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0531 21:54:50.547785  4693 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0531 21:54:50.547806  4693 authenticator.cpp:318] Authentication success
I0531 21:54:50.547849  4686 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_bFVQPx/meta'
I0531 21:54:50.547917  4685 authenticatee.cpp:299] Authentication success
I0531 21:54:50.548082  4693 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(436)@172.17.0.2:44706
I0531 21:54:50.548099  4683 master.cpp:7451] Successfully authenticated principal 'test-principal' at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706
I0531 21:54:50.548416  4695 sched.cpp:513] Successfully authenticated with master master@172.17.0.2:44706
I0531 21:54:50.548437  4695 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.2:44706
I0531 21:54:50.548514  4690 status_update_manager.cpp:203] Recovering status update manager
I0531 21:54:50.548566  4695 sched.cpp:869] Will retry registration in 1.223932653secs if necessary
I0531 21:54:50.548669  4688 master.cpp:2810] Received SUBSCRIBE call for framework 'default' at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706
I0531 21:54:50.548738  4688 master.cpp:2194] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0531 21:54:50.548902  4687 slave.cpp:6083] Finished recovery
I0531 21:54:50.549111  4691 master.cpp:2887] Subscribing framework default with checkpointing disabled and capabilities [  ]
I0531 21:54:50.549388  4687 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0531 21:54:50.549621  4689 sched.cpp:759] Framework registered with 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.549636  4684 slave.cpp:929] New master detected at master@172.17.0.2:44706
I0531 21:54:50.549666  4687 status_update_manager.cpp:177] Pausing sending status updates
I0531 21:54:50.549679  4689 sched.cpp:773] Scheduler::registered took 31826ns
I0531 21:54:50.549721  4692 hierarchical.cpp:292] Added framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.549758  4684 slave.cpp:964] Detecting new master
I0531 21:54:50.549861  4692 hierarchical.cpp:1861] No allocations performed
I0531 21:54:50.549890  4684 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0531 21:54:50.549899  4692 hierarchical.cpp:1951] No inverse offers to send out!
I0531 21:54:50.549998  4692 hierarchical.cpp:1445] Performed allocation for 0 agents in 166932ns
I0531 21:54:50.554121  4691 slave.cpp:991] Authenticating with master master@172.17.0.2:44706
I0531 21:54:50.554204  4691 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0531 21:54:50.554406  4693 authenticatee.cpp:121] Creating new client SASL connection
I0531 21:54:50.554615  4695 master.cpp:7421] Authenticating slave(202)@172.17.0.2:44706
I0531 21:54:50.554704  4685 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(437)@172.17.0.2:44706
I0531 21:54:50.554910  4687 authenticator.cpp:98] Creating new server SASL connection
I0531 21:54:50.555200  4686 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0531 21:54:50.555223  4686 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0531 21:54:50.555302  4686 authenticator.cpp:204] Received SASL authentication start
I0531 21:54:50.555356  4686 authenticator.cpp:326] Authentication requires more steps
I0531 21:54:50.555529  4692 authenticatee.cpp:259] Received SASL authentication step
I0531 21:54:50.555629  4692 authenticator.cpp:232] Received SASL authentication step
I0531 21:54:50.555660  4692 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f52a71e21c91' server FQDN: 'f52a71e21c91' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0531 21:54:50.555680  4692 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0531 21:54:50.555711  4692 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0531 21:54:50.555737  4692 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f52a71e21c91' server FQDN: 'f52a71e21c91' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0531 21:54:50.555750  4692 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0531 21:54:50.555759  4692 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0531 21:54:50.555773  4692 authenticator.cpp:318] Authentication success
I0531 21:54:50.555896  4689 authenticatee.cpp:299] Authentication success
I0531 21:54:50.555907  4685 master.cpp:7451] Successfully authenticated principal 'test-principal' at slave(202)@172.17.0.2:44706
I0531 21:54:50.555958  4692 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(437)@172.17.0.2:44706
I0531 21:54:50.556275  4691 slave.cpp:1086] Successfully authenticated with master master@172.17.0.2:44706
I0531 21:54:50.556450  4691 slave.cpp:1506] Will retry registration in 8.787619ms if necessary
I0531 21:54:50.556588  4692 master.cpp:5424] Received register agent message from slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.556704  4692 master.cpp:3656] Authorizing agent with principal 'test-principal'
I0531 21:54:50.557075  4687 master.cpp:5484] Authorized registration of agent at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.557210  4687 master.cpp:5563] Registering agent at slave(202)@172.17.0.2:44706 (f52a71e21c91) with id 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0
I0531 21:54:50.557726  4684 registrar.cpp:493] Applied 1 operations in 66845ns; attempting to update the registry
I0531 21:54:50.558588  4684 registrar.cpp:550] Successfully updated the registry in 798976ns
I0531 21:54:50.558799  4694 master.cpp:5610] Admitted agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.559403  4680 slave.cpp:4809] Received ping from slave-observer(197)@172.17.0.2:44706
I0531 21:54:50.559738  4680 slave.cpp:1132] Registered with master master@172.17.0.2:44706; given agent ID 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0
I0531 21:54:50.559653  4694 master.cpp:5641] Registered agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0531 21:54:50.559907  4693 status_update_manager.cpp:184] Resuming sending status updates
I0531 21:54:50.560031  4681 hierarchical.cpp:544] Added agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 (f52a71e21c91) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0531 21:54:50.560160  4680 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_bFVQPx/meta/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/slave.info'
I0531 21:54:50.560544  4680 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0531 21:54:50.560745  4694 master.cpp:6294] Received update of agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91) with total oversubscribed resources {}
I0531 21:54:50.561153  4681 hierarchical.cpp:1951] No inverse offers to send out!
I0531 21:54:50.561197  4681 hierarchical.cpp:1445] Performed allocation for 1 agents in 1.011402ms
I0531 21:54:50.561666  4683 master.cpp:7251] Sending 1 offers to framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 (default) at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706
I0531 21:54:50.562134  4683 sched.cpp:933] Scheduler::resourceOffers took 117772ns
I0531 21:54:50.564627  4682 master.cpp:3871] Processing ACCEPT call for offers: [ 87984e3f-86f9-4870-8e02-a5fb4bea627c-O0 ] on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91) for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 (default) at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706
I0531 21:54:50.564715  4682 master.cpp:3423] Authorizing framework principal 'test-principal' to launch task 1
I0531 21:54:50.564925  4682 master.cpp:3423] Authorizing framework principal 'test-principal' to launch task 2
W0531 21:54:50.566673  4691 validation.cpp:1284] 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.
W0531 21:54:50.566705  4691 validation.cpp:1296] 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.
I0531 21:54:50.567037  4691 master.cpp:9264] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.567234  4691 master.cpp:4526] Launching task 1 of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 (default) at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.567662  4682 slave.cpp:1616] Got assigned task '1' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.568167  4682 slave.cpp:1897] Authorizing task '1' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
W0531 21:54:50.568169  4691 validation.cpp:1284] 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.
W0531 21:54:50.568194  4691 validation.cpp:1296] 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.
I0531 21:54:50.568210  4682 slave.cpp:6702] Authorizing framework principal 'test-principal' to launch task 1
I0531 21:54:50.568531  4691 master.cpp:9264] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.568696  4691 master.cpp:4526] Launching task 2 of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 (default) at scheduler-a5ce5615-c5eb-420f-8d28-4b889fa4e20d@172.17.0.2:44706 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 at slave(202)@172.17.0.2:44706 (f52a71e21c91)
I0531 21:54:50.569103  4690 slave.cpp:1616] Got assigned task '2' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.569703  4690 slave.cpp:2084] Launching task '1' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.570372  4690 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_bFVQPx/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/frameworks/87984e3f-86f9-4870-8e02-a5fb4bea627c-0000/executors/executor-1/runs/a552f15f-1408-4fed-9c11-aeaac849e8ce' to user 'mesos'
I0531 21:54:50.570644  4690 slave.cpp:7042] Launching executor 'executor-1' of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_bFVQPx/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/frameworks/87984e3f-86f9-4870-8e02-a5fb4bea627c-0000/executors/executor-1/runs/a552f15f-1408-4fed-9c11-aeaac849e8ce'
I0531 21:54:50.571002  4690 slave.cpp:2779] Launching container a552f15f-1408-4fed-9c11-aeaac849e8ce for executor 'executor-1' of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.571158  4686 hierarchical.cpp:869] Updated allocation of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 on agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-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]
I0531 21:54:50.571390  4690 slave.cpp:2313] Queued task '1' for executor 'executor-1' of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.571542  4690 slave.cpp:1897] Authorizing task '2' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.571601  4690 slave.cpp:6702] Authorizing framework principal 'test-principal' to launch task 2
I0531 21:54:50.571867  4686 hierarchical.cpp:1133] 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 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 from framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.571919  4686 hierarchical.cpp:1170] Framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 filtered agent 87984e3f-86f9-4870-8e02-a5fb4bea627c-S0 for 5secs
I0531 21:54:50.572083  4690 slave.cpp:882] Successfully attached file '/tmp/MasterTest_MultipleExecutors_bFVQPx/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/frameworks/87984e3f-86f9-4870-8e02-a5fb4bea627c-0000/executors/executor-1/runs/a552f15f-1408-4fed-9c11-aeaac849e8ce'
I0531 21:54:50.572450  4695 slave.cpp:2084] Launching task '2' for framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000
I0531 21:54:50.572947  4695 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_bFVQPx/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/frameworks/87984e3f-86f9-4870-8e02-a5fb4bea627c-0000/executors/executor-2/runs/d65890e0-99eb-4447-8bc1-1a3ed114ba85' to user 'mesos'
I0531 21:54:50.573194  4695 slave.cpp:7042] Launching executor 'executor-2' of framework 87984e3f-86f9-4870-8e02-a5fb4bea627c-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_bFVQPx/slaves/87984e3f-86f9-4870-8e02-a5fb4bea627c-S0/frameworks/87984e3f-86f9-4870-8e02-a5fb4bea627c-0000/executors/executor-2/runs/d65890e0-99eb-4447-8bc1-1a3ed114ba85'
*** Aborted at 1496267690 (unix time) try "date -d @1496267690" if you are using GNU date ***
PC: @     0x2aed02ad382d (unknown)
I0531 21:54:50.573925  4694 exec.cpp:162] Version: 1.4.0
*** SIGSEGV (@0xb0) received by PID 4661 (TID 0x2aed0cb40700) from PID 176; stack trace: ***
I0531 21:54:50.574179  4691 exec.cpp:212] Executor started at: executor(75)@172.17.0.2:44706 with pid 4661
    @     0x2aed587d9417 (unknown)
    @     0x2aed587dd6f9 (unknown)
    @     0x2aed0288a330 (unknown)
    @     0x2aed02ad382d (unknown)
    @     0x2aecf7d313f5 os::getenv()
    @     0x2aecff58cf07 mesos::internal::slave::executorEnvironment()
    @     0x2aecff564199 mesos::internal::slave::Slave::launchExecutor()
    @     0x2aecff55f8b6 mesos::internal::slave::Slave::__run()
    @     0x2aecff5c4d65 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEES9_SC_SF_SK_SO_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES19_
    @     0x2aecff5fefac _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSM_INS5_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS0_3PIDIT_EEMSW_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x2aed003ee983 std::function<>::operator()()
    @     0x2aed003d3ddf process::ProcessBase::visit()
    @     0x2aed003de7c0 process::DispatchEvent::visit()
    @     0x2aecf7d05072 process::ProcessBase::serve()
    @     0x2aed003d00a0 process::ProcessManager::resume()
    @     0x2aed003cc274 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
    @     0x2aed003ddecc _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2aed003dde23 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
    @     0x2aed003dddbc _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2aed0210ba60 (unknown)
    @     0x2aed02882184 start_thread
    @     0x2aed02b95bed (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1496264571-32645
Untagged: mesos-1496264571-32645:latest
Deleted: sha256:82acc706ea83e3eb1426daa7e08f70366a1551d95a2f7bae6e167a006de4f6ba
Deleted: sha256:1d87fa61d5df1886e5f1a24c744ffe1c0b21186d32c849361aff43309cdcc525
Deleted: sha256:897aeb93a0ae66016c719222a40adf70ea353221d1ab2283f8399435238ac960
Deleted: sha256:5db9c26c9c79dece1bed3da957ae523da289e13be7d896c1efee8c04c171f521
Deleted: sha256:47c832b3b2e2ffafc14a9d947e234b4cf8365eb60f40d05111adf34d5c69a537
Deleted: sha256:001e3a734c38f9ca6c839f6b11373521e39e449c11aa3515767baf05340febcc
Deleted: sha256:c2c6f95d062639941ef13e4c8389f1e5926d997276cedf24661a0bf90e9fb7c6
Deleted: sha256:ad7b73832e4330881f88de1681c5637e3f42438391ae6387c384121852600760
Deleted: sha256:8063d6e0d2bd202b2709947d4c678128069d910fa11afb45db956e3d26568fda
Deleted: sha256:831c33676129dcdb9e743ae5a76b775eaccee91a5ba643543e2d9ec33ebce426
Deleted: sha256:804e7631d21e72c939e9a21f718c7bef32881904d6c9e5d231def9b0afce3c6e
Deleted: sha256:0ee3e2103b9e8dcafa133279143324178ed61745c97014bb5d2d7f823103807c
Deleted: sha256:b267862cdbf8137c57e653f95a6202863e2e8d009836ad88727c05b5ea28c2be
Deleted: sha256:70d317e7c0134aed40ac0b95ca2a28e3e94dd76bf9ab06f88138f2d2b375d5db
Deleted: sha256:591e4c383df0c7045a0519f09eb35d0831e5257b8b2a81ad2cce3fcba71d76e2
Deleted: sha256:6c406d644f1ec9aad8fb0300a85652a948eda532b5b8b496380ee56edb6454eb
Deleted: sha256:253ac373175e315e8811e44d94bb70bc944bc683a495ea20a3e3a51c9d8a9032
Deleted: sha256:3d820514b74d9814b8a3667946f5ceddb38103c9f5063e509d363072ff2efb03
Deleted: sha256:8d9e89e56f9486646fd13045760f584a09b54ce50c827c4892f097568336895d
Deleted: sha256:2b121bc39a3873571f8e459e1a819c8bcb572bc8791e19ffd371352f416af36b
Deleted: sha256:f4a9956ebe8347c506ede74d5cdc8b1f53e38936605bedba423f4178f930edf8
Deleted: sha256:2542caeef534413fed40777a2b2a82fc3b6b13cc12d7be2c2ea806349c28a106
Deleted: sha256:200f82df6cb02deeb2a12ea2603ec010bacb5cdff39e876cc63695f0dda1451c
Deleted: sha256:c573cf95a72a92e8d4d4eb032a0e16d31423a9726cd2e3f58d3240575b9c7d25
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Reviewbot #18228

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18228/display/redirect?page=changes>