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/02/21 11:09:15 UTC

Build failed in Jenkins: Mesos-Reviewbot #17174

See <https://builds.apache.org/job/Mesos-Reviewbot/17174/display/redirect?page=changes>

Changes:

[haosdent] Added `mesos-go-http` to `docs/api-client-libraries.md`.

------------------------------------------
[...truncated 10.59 MB...]
I0221 11:09:09.573999 30430 slave.cpp:4324] Sending message for framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 to scheduler-cedf3e62-ee9a-4c31-853a-fbadba76a4b9@172.17.0.3:35927
I0221 11:09:09.574314 30417 sched.cpp:1177] Scheduler::frameworkMessage took 75831ns
I0221 11:09:09.574776 30398 sched.cpp:2021] Asked to stop the driver
I0221 11:09:09.574899 30421 sched.cpp:1203] Stopping framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.575219 30427 master.cpp:7750] Processing TEARDOWN call for framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 (default) at scheduler-cedf3e62-ee9a-4c31-853a-fbadba76a4b9@172.17.0.3:35927
I0221 11:09:09.575314 30427 master.cpp:7762] Removing framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 (default) at scheduler-cedf3e62-ee9a-4c31-853a-fbadba76a4b9@172.17.0.3:35927
I0221 11:09:09.575397 30427 master.cpp:3134] Deactivating framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 (default) at scheduler-cedf3e62-ee9a-4c31-853a-fbadba76a4b9@172.17.0.3:35927
I0221 11:09:09.575778 30419 hierarchical.cpp:415] Deactivated framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.576287 30421 slave.cpp:2658] Asked to shut down framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 by master@172.17.0.3:35927
I0221 11:09:09.576336 30421 slave.cpp:2683] Shutting down framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.576395 30421 slave.cpp:5083] Shutting down executor 'default' of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 at executor(74)@172.17.0.3:35927
I0221 11:09:09.576622 30427 master.cpp:8347] Updating the state of task 1 of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0221 11:09:09.576920 30424 exec.cpp:415] Executor asked to shutdown
I0221 11:09:09.577191 30424 exec.cpp:430] Executor::shutdown took 236041ns
I0221 11:09:09.577481 30431 slave.cpp:4388] Got exited event for executor(74)@172.17.0.3:35927
I0221 11:09:09.577930 30421 slave.cpp:4769] Executor 'default' of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 exited with status 0
I0221 11:09:09.578039 30421 slave.cpp:4869] Cleaning up executor 'default' of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 at executor(74)@172.17.0.3:35927
I0221 11:09:09.578326 30424 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_CfHwas/slaves/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0/frameworks/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000/executors/default/runs/5f947157-badf-4cd7-8e85-77c3fbe2846b' for gc 6.9999933073363days in the future
I0221 11:09:09.578421 30427 master.cpp:8441] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 on agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.578672 30421 slave.cpp:4957] Cleaning up framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.578721 30429 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_CfHwas/slaves/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0/frameworks/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000/executors/default' for gc 6.99999330330963days in the future
I0221 11:09:09.578958 30427 master.cpp:8470] Removing executor 'default' with resources {} of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 on agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.578986 30421 slave.cpp:803] Agent terminating
I0221 11:09:09.579040 30429 status_update_manager.cpp:285] Closing status update streams for framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.579036 30418 hierarchical.cpp:1064] 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 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 from framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.579097 30429 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.579238 30418 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_CfHwas/slaves/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0/frameworks/3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000' for gc 6.99999330029926days in the future
W0221 11:09:09.579727 30427 master.cpp:6323] Ignoring unknown exited executor 'default' of framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000 on agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.579754 30423 hierarchical.cpp:362] Removed framework 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-0000
I0221 11:09:09.579941 30427 master.cpp:1264] Agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba) disconnected
I0221 11:09:09.579978 30427 master.cpp:3171] Disconnecting agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.580073 30427 master.cpp:3190] Deactivating agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 at slave(179)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.580207 30418 hierarchical.cpp:618] Agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0 deactivated
I0221 11:09:09.583427 30427 master.cpp:1103] Master terminating
I0221 11:09:09.584358 30430 hierarchical.cpp:549] Removed agent 3cafa7e1-ec6b-4f4e-9c87-7f8a81d0f9d7-S0
[       OK ] MasterTest.FrameworkMessage (86 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0221 11:09:09.592073 30398 cluster.cpp:160] Creating default 'local' authorizer
I0221 11:09:09.595180 30427 master.cpp:383] Master 5a712282-ff11-40d0-bb58-92549e683777 (dbda0ff626ba) started on 172.17.0.3:35927
I0221 11:09:09.595211 30427 master.cpp:385] 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/f5ECLi/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="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/f5ECLi/master" --zk_session_timeout="10secs"
I0221 11:09:09.595707 30427 master.cpp:435] Master only allowing authenticated frameworks to register
I0221 11:09:09.595724 30427 master.cpp:449] Master only allowing authenticated agents to register
I0221 11:09:09.595732 30427 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0221 11:09:09.595746 30427 credentials.hpp:37] Loading credentials for authentication from '/tmp/f5ECLi/credentials'
I0221 11:09:09.596078 30427 master.cpp:507] Using default 'crammd5' authenticator
I0221 11:09:09.596254 30427 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0221 11:09:09.596541 30427 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0221 11:09:09.596997 30427 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0221 11:09:09.597126 30427 master.cpp:587] Authorization enabled
I0221 11:09:09.597376 30421 whitelist_watcher.cpp:77] No whitelist given
I0221 11:09:09.597406 30419 hierarchical.cpp:161] Initialized hierarchical allocator process
I0221 11:09:09.600958 30420 master.cpp:2122] Elected as the leading master!
I0221 11:09:09.600994 30420 master.cpp:1646] Recovering from registrar
I0221 11:09:09.601218 30431 registrar.cpp:329] Recovering registrar
I0221 11:09:09.602067 30429 registrar.cpp:362] Successfully fetched the registry (0B) in 779776ns
I0221 11:09:09.602208 30429 registrar.cpp:461] Applied 1 operations in 26350ns; attempting to update the registry
I0221 11:09:09.603188 30431 registrar.cpp:506] Successfully updated the registry in 902144ns
I0221 11:09:09.603365 30431 registrar.cpp:392] Successfully recovered registrar
I0221 11:09:09.604029 30420 master.cpp:1760] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0221 11:09:09.604058 30429 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0221 11:09:09.609760 30398 cluster.cpp:446] Creating default 'local' authorizer
I0221 11:09:09.611784 30418 slave.cpp:211] Mesos agent started on (180)@172.17.0.3:35927
I0221 11:09:09.612030 30418 slave.cpp:212] 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_JGSNne/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/MasterTest_MultipleExecutors_JGSNne/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/MasterTest_MultipleExecutors_JGSNne/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.3.0/_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/MasterTest_MultipleExecutors_JGSNne" --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_pMwHzg"
I0221 11:09:09.612874 30418 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_JGSNne/credential'
I0221 11:09:09.613142 30418 slave.cpp:354] Agent using credential for: test-principal
I0221 11:09:09.613250 30418 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_JGSNne/http_credentials'
I0221 11:09:09.613292 30398 sched.cpp:232] Version: 1.3.0
I0221 11:09:09.613665 30418 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0221 11:09:09.613909 30418 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0221 11:09:09.614104 30417 sched.cpp:336] New master detected at master@172.17.0.3:35927
I0221 11:09:09.614285 30417 sched.cpp:407] Authenticating with master master@172.17.0.3:35927
I0221 11:09:09.614315 30417 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0221 11:09:09.614621 30421 authenticatee.cpp:121] Creating new client SASL connection
I0221 11:09:09.614987 30423 master.cpp:7208] Authenticating scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927
I0221 11:09:09.615145 30431 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(414)@172.17.0.3:35927
I0221 11:09:09.615439 30427 authenticator.cpp:98] Creating new server SASL connection
I0221 11:09:09.615711 30430 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0221 11:09:09.615754 30430 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0221 11:09:09.615924 30425 authenticator.cpp:204] Received SASL authentication start
I0221 11:09:09.616014 30425 authenticator.cpp:326] Authentication requires more steps
I0221 11:09:09.616200 30421 authenticatee.cpp:259] Received SASL authentication step
I0221 11:09:09.616339 30421 authenticator.cpp:232] Received SASL authentication step
I0221 11:09:09.616377 30421 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dbda0ff626ba' server FQDN: 'dbda0ff626ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0221 11:09:09.616396 30421 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0221 11:09:09.616315 30418 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0221 11:09:09.616447 30418 slave.cpp:549] Agent attributes: [  ]
I0221 11:09:09.616456 30421 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0221 11:09:09.616514 30418 slave.cpp:554] Agent hostname: dbda0ff626ba
I0221 11:09:09.616542 30421 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dbda0ff626ba' server FQDN: 'dbda0ff626ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0221 11:09:09.616684 30421 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0221 11:09:09.616706 30420 status_update_manager.cpp:177] Pausing sending status updates
I0221 11:09:09.616747 30421 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0221 11:09:09.616802 30421 authenticator.cpp:318] Authentication success
I0221 11:09:09.616914 30430 authenticatee.cpp:299] Authentication success
I0221 11:09:09.617013 30432 master.cpp:7238] Successfully authenticated principal 'test-principal' at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927
I0221 11:09:09.617120 30425 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(414)@172.17.0.3:35927
I0221 11:09:09.617308 30427 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:35927
I0221 11:09:09.617341 30427 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:35927
I0221 11:09:09.617460 30427 sched.cpp:869] Will retry registration in 164.656327ms if necessary
I0221 11:09:09.617655 30428 master.cpp:2789] Received SUBSCRIBE call for framework 'default' at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927
I0221 11:09:09.617786 30428 master.cpp:2158] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0221 11:09:09.618362 30422 master.cpp:2866] Subscribing framework default with checkpointing disabled and capabilities [  ]
I0221 11:09:09.618676 30417 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_pMwHzg/meta'
I0221 11:09:09.619016 30422 sched.cpp:759] Framework registered with 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.619102 30422 sched.cpp:773] Scheduler::registered took 46692ns
I0221 11:09:09.619151 30423 status_update_manager.cpp:203] Recovering status update manager
I0221 11:09:09.619168 30432 hierarchical.cpp:286] Added framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.619377 30432 hierarchical.cpp:1810] No allocations performed
I0221 11:09:09.619433 30432 hierarchical.cpp:1900] No inverse offers to send out!
I0221 11:09:09.619554 30432 hierarchical.cpp:1394] Performed allocation for 0 agents in 229376ns
I0221 11:09:09.619825 30432 slave.cpp:5558] Finished recovery
I0221 11:09:09.620470 30432 slave.cpp:5732] Querying resource estimator for oversubscribable resources
I0221 11:09:09.620785 30418 status_update_manager.cpp:177] Pausing sending status updates
I0221 11:09:09.620790 30432 slave.cpp:931] New master detected at master@172.17.0.3:35927
I0221 11:09:09.620939 30432 slave.cpp:966] Detecting new master
I0221 11:09:09.621098 30432 slave.cpp:5746] Received oversubscribable resources {} from the resource estimator
I0221 11:09:09.628262 30430 slave.cpp:993] Authenticating with master master@172.17.0.3:35927
I0221 11:09:09.628388 30430 slave.cpp:1004] Using default CRAM-MD5 authenticatee
I0221 11:09:09.628726 30427 authenticatee.cpp:121] Creating new client SASL connection
I0221 11:09:09.629014 30432 master.cpp:7208] Authenticating slave(180)@172.17.0.3:35927
I0221 11:09:09.629129 30423 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(415)@172.17.0.3:35927
I0221 11:09:09.629444 30429 authenticator.cpp:98] Creating new server SASL connection
I0221 11:09:09.629762 30432 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0221 11:09:09.629798 30432 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0221 11:09:09.629925 30421 authenticator.cpp:204] Received SASL authentication start
I0221 11:09:09.629989 30421 authenticator.cpp:326] Authentication requires more steps
I0221 11:09:09.630134 30430 authenticatee.cpp:259] Received SASL authentication step
I0221 11:09:09.630295 30420 authenticator.cpp:232] Received SASL authentication step
I0221 11:09:09.630331 30420 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dbda0ff626ba' server FQDN: 'dbda0ff626ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0221 11:09:09.630345 30420 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0221 11:09:09.630378 30420 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0221 11:09:09.630403 30420 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dbda0ff626ba' server FQDN: 'dbda0ff626ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0221 11:09:09.630414 30420 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0221 11:09:09.630424 30420 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0221 11:09:09.630441 30420 authenticator.cpp:318] Authentication success
I0221 11:09:09.630554 30424 authenticatee.cpp:299] Authentication success
I0221 11:09:09.630604 30426 master.cpp:7238] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.3:35927
I0221 11:09:09.630646 30417 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(415)@172.17.0.3:35927
I0221 11:09:09.631078 30418 slave.cpp:1088] Successfully authenticated with master master@172.17.0.3:35927
I0221 11:09:09.631348 30418 slave.cpp:1515] Will retry registration in 849853ns if necessary
I0221 11:09:09.631577 30420 master.cpp:5423] Registering agent at slave(180)@172.17.0.3:35927 (dbda0ff626ba) with id 5a712282-ff11-40d0-bb58-92549e683777-S0
I0221 11:09:09.632184 30424 registrar.cpp:461] Applied 1 operations in 78275ns; attempting to update the registry
I0221 11:09:09.632958 30419 slave.cpp:1515] Will retry registration in 8.061108ms if necessary
I0221 11:09:09.633148 30421 master.cpp:5411] Ignoring register agent message from slave(180)@172.17.0.3:35927 (dbda0ff626ba) as admission is already in progress
I0221 11:09:09.634210 30424 registrar.cpp:506] Successfully updated the registry in 1.934848ms
I0221 11:09:09.635174 30419 slave.cpp:4346] Received ping from slave-observer(178)@172.17.0.3:35927
I0221 11:09:09.635504 30423 slave.cpp:1134] Registered with master master@172.17.0.3:35927; given agent ID 5a712282-ff11-40d0-bb58-92549e683777-S0
I0221 11:09:09.635534 30423 fetcher.cpp:90] Clearing fetcher cache
I0221 11:09:09.635402 30426 master.cpp:5497] Registered agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0221 11:09:09.635735 30425 status_update_manager.cpp:184] Resuming sending status updates
I0221 11:09:09.636037 30427 hierarchical.cpp:516] Added agent 5a712282-ff11-40d0-bb58-92549e683777-S0 (dbda0ff626ba) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0221 11:09:09.636057 30423 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_pMwHzg/meta/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/slave.info'
I0221 11:09:09.636528 30423 slave.cpp:1200] Forwarding total oversubscribed resources {}
I0221 11:09:09.636945 30429 master.cpp:6054] Received update of agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba) with total oversubscribed resources {}
I0221 11:09:09.637794 30427 hierarchical.cpp:1900] No inverse offers to send out!
I0221 11:09:09.637861 30427 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.658043ms
I0221 11:09:09.638051 30427 hierarchical.cpp:589] Agent 5a712282-ff11-40d0-bb58-92549e683777-S0 (dbda0ff626ba) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000])
I0221 11:09:09.638298 30427 hierarchical.cpp:1810] No allocations performed
I0221 11:09:09.638350 30427 hierarchical.cpp:1900] No inverse offers to send out!
I0221 11:09:09.638402 30427 hierarchical.cpp:1394] Performed allocation for 1 agents in 218466ns
I0221 11:09:09.638759 30423 master.cpp:7037] Sending 1 offers to framework 5a712282-ff11-40d0-bb58-92549e683777-0000 (default) at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927
I0221 11:09:09.639431 30421 sched.cpp:933] Scheduler::resourceOffers took 152233ns
I0221 11:09:09.642474 30424 master.cpp:3825] Processing ACCEPT call for offers: [ 5a712282-ff11-40d0-bb58-92549e683777-O0 ] on agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba) for framework 5a712282-ff11-40d0-bb58-92549e683777-0000 (default) at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927
I0221 11:09:09.642596 30424 master.cpp:3401] Authorizing framework principal 'test-principal' to launch task 1
I0221 11:09:09.642966 30424 master.cpp:3401] Authorizing framework principal 'test-principal' to launch task 2
W0221 11:09:09.645736 30418 validation.cpp:1064] 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.
W0221 11:09:09.645802 30418 validation.cpp:1076] 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.
I0221 11:09:09.646304 30418 master.cpp:9098] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.646569 30418 master.cpp:4475] Launching task 1 of framework 5a712282-ff11-40d0-bb58-92549e683777-0000 (default) at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.647214 30421 slave.cpp:1625] Got assigned task '1' for framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.648083 30421 slave.cpp:1785] Launching task '1' for framework 5a712282-ff11-40d0-bb58-92549e683777-0000
W0221 11:09:09.648535 30418 validation.cpp:1064] 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.
W0221 11:09:09.648620 30418 validation.cpp:1076] 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.
I0221 11:09:09.649118 30421 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_pMwHzg/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/frameworks/5a712282-ff11-40d0-bb58-92549e683777-0000/executors/executor-1/runs/a4a20ddd-1a91-465c-b91f-02072cba6b04' to user 'mesos'
I0221 11:09:09.649087 30418 master.cpp:9098] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.649312 30418 master.cpp:4475] Launching task 2 of framework 5a712282-ff11-40d0-bb58-92549e683777-0000 (default) at scheduler-543fc2ea-d4a3-42aa-9035-959edb509274@172.17.0.3:35927 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5a712282-ff11-40d0-bb58-92549e683777-S0 at slave(180)@172.17.0.3:35927 (dbda0ff626ba)
I0221 11:09:09.649401 30421 slave.cpp:6480] Launching executor 'executor-1' of framework 5a712282-ff11-40d0-bb58-92549e683777-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_pMwHzg/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/frameworks/5a712282-ff11-40d0-bb58-92549e683777-0000/executors/executor-1/runs/a4a20ddd-1a91-465c-b91f-02072cba6b04'
I0221 11:09:09.649920 30421 slave.cpp:2118] Queued task '1' for executor 'executor-1' of framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.650259 30421 slave.cpp:1625] Got assigned task '2' for framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.650811 30421 slave.cpp:884] Successfully attached file '/tmp/MasterTest_MultipleExecutors_pMwHzg/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/frameworks/5a712282-ff11-40d0-bb58-92549e683777-0000/executors/executor-1/runs/a4a20ddd-1a91-465c-b91f-02072cba6b04'
I0221 11:09:09.650928 30421 slave.cpp:1785] Launching task '2' for framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.651609 30421 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_pMwHzg/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/frameworks/5a712282-ff11-40d0-bb58-92549e683777-0000/executors/executor-2/runs/ca19b89d-f182-42be-b395-c2c07543d302' to user 'mesos'
I0221 11:09:09.651887 30421 slave.cpp:6480] Launching executor 'executor-2' of framework 5a712282-ff11-40d0-bb58-92549e683777-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_pMwHzg/slaves/5a712282-ff11-40d0-bb58-92549e683777-S0/frameworks/5a712282-ff11-40d0-bb58-92549e683777-0000/executors/executor-2/runs/ca19b89d-f182-42be-b395-c2c07543d302'
*** Aborted at 1487675349 (unix time) try "date -d @1487675349" if you are using GNU date ***
PC: @     0x2afa875c482d (unknown)
I0221 11:09:09.652539 30428 hierarchical.cpp:807] Updated allocation of framework 5a712282-ff11-40d0-bb58-92549e683777-0000 on agent 5a712282-ff11-40d0-bb58-92549e683777-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]
I0221 11:09:09.652556 30420 exec.cpp:162] Version: 1.3.0
*** SIGSEGV (@0x31) received by PID 30398 (TID 0x2afa8fffa700) from PID 49; stack trace: ***
I0221 11:09:09.652997 30423 exec.cpp:212] Executor started at: executor(75)@172.17.0.3:35927 with pid 30398
I0221 11:09:09.653401 30428 hierarchical.cpp:1064] 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 5a712282-ff11-40d0-bb58-92549e683777-S0 from framework 5a712282-ff11-40d0-bb58-92549e683777-0000
I0221 11:09:09.653467 30428 hierarchical.cpp:1101] Framework 5a712282-ff11-40d0-bb58-92549e683777-0000 filtered agent 5a712282-ff11-40d0-bb58-92549e683777-S0 for 5secs
    @     0x2afad8be32d7 (unknown)
    @     0x2afad8be75b9 (unknown)
    @     0x2afa8737b330 (unknown)
    @     0x2afa875c482d (unknown)
    @     0x2afa7d29b1a0 os::getenv()
    @     0x2afa843030dd mesos::internal::slave::executorEnvironment()
    @     0x2afa842fd8b0 mesos::internal::slave::Framework::launchExecutor()
    @     0x2afa842d76e5 mesos::internal::slave::Slave::_run()
    @     0x2afa843312af _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureIbEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSF_INS1_13TaskGroupInfoEES6_S9_SC_SH_SL_EEvRKNS_3PIDIT_EEMSP_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES16_
    @     0x2afa84365ff1 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureIbEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSJ_INS5_13TaskGroupInfoEESA_SD_SG_SL_SP_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x2afa850af96f std::function<>::operator()()
    @     0x2afa8509583f process::ProcessBase::visit()
    @     0x2afa850a00be process::DispatchEvent::visit()
    @     0x2afa7d26f4e6 process::ProcessBase::serve()
    @     0x2afa85091b2c process::ProcessManager::resume()
    @     0x2afa8508e370 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
    @     0x2afa8509f7f8 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2afa8509f74f _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
    @     0x2afa8509f6e8 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2afa86bfca60 (unknown)
    @     0x2afa87373184 start_thread
    @     0x2afa8768337d (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.3.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.3.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.3.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.3.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1487672707-18084
Untagged: mesos-1487672707-18084:latest
Deleted: sha256:506e3c2d2a1024e41b38ca9f392c64e9d510e8d3f8fa85c6ec30d29daa410438
Deleted: sha256:93710ab5aeb8a78ca6b447ef11f2d598589524efdd23db031b53982fe17b5a1c
Deleted: sha256:dd9aec64a903feef0baf5305a49f5ed13e25ff835c27265076cd0fe8e805537d
Deleted: sha256:3f6b5513dbf5fc1d5fe41d52c7559db8d05b5266e2a509626e1452ccb124d6d0
Deleted: sha256:ed6a68c888e822b3941714dc74a1983e097b27e3fc5f3eafe36d7697bb573683
Deleted: sha256:0ff0d1aff9ed01a41844e6b132f3268e3c8b504f5d0180f7d92b00f53f14c8a9
Deleted: sha256:987323c50c90a60882965f40af496c9870402dd39c3dd667c1a40f4d1f17ce5e
Deleted: sha256:8a95a7cc191fd8ad14450b8745039722eaaf765f8912445a7ac3b8faf4d4f71b
Deleted: sha256:df91285164919f552fadbc3082b9b096f9ac3dceccb0cbd3342257f9f084f90a
Deleted: sha256:575c7cb6b4d505f9acbd72737f5da6b68e443bf47a063cabd1bcd05b048d0f2a
Deleted: sha256:5e5097512fdc4d382b989f7d34d7a8d5a066d118a1ae55c0ecaa4e8d66061153
Deleted: sha256:3317d81d4b4ffb31468df10bec3004f638b3fe22ee5fd9ab5d96b69b4070954d
Deleted: sha256:add61c14484bb6891c1ff8f77c9d2a21f658cb92f5f7e5c5c17bd5842a8bca7c
Deleted: sha256:8087b9e46c8f217789e0cb4e2f927d5db064712a9b426b961452ca909416ec00
Deleted: sha256:be7039b00ac204cdcdc5e0fe9d8162c56e9671f494a8eee175375d40af3cb75e
Deleted: sha256:2dc5698eb69b4c872a282083037a2602c237d56c259d12db0507edc9f93c09b9
Deleted: sha256:4014a346d04761a555f7703c75ac3004912afc41a6dd67cbe527e249efdd87fb
Deleted: sha256:bab03f20791abcccff807f2dc5102c74be1079c38942e796c4ffda573060fc6b
Deleted: sha256:5bd6ce7adc567b117f733b064e4b1b0522bb6e27b817a6929d584794b7ba242e
Deleted: sha256:26c25451a73c8588ca9627e96d89ab3ebd81b1249364e3ac5cc760858cf89ea6
Deleted: sha256:00557dd7713d9a17478a2503cec08e57226f484f29baf760ca739437bf9b48c0
Deleted: sha256:0d6fd9192176e4e3384f26931592fe516432394240569b15b14792bfe615f41f
Deleted: sha256:4b3265cd121bfd3feebdf20ddeea2a615b2b1512bb45dacd7e2c6c611c80ec44
Deleted: sha256:33a1578b4c44e740d84568b8d045d1ab869bd4832b6e52d75ea3955ace28415a
Build step 'Execute shell' marked build as failure

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

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/17175/display/redirect>