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/11/14 01:36:57 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4451
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4451/display/redirect?page=changes>
Changes:
[yujie.jay] Handled the resource conversion for new operations in master.
[songzihao1990] Added a test `CgroupsIsolatorTest.ROOT_CGROUPS_BlkioUsage`.
------------------------------------------
[...truncated 27.02 MB...]
3: I1114 01:36:48.748714 15986 slave.cpp:610] Agent hostname: 48c37892027e
3: I1114 01:36:48.748848 15985 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:36:48.750574 15971 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_GLixaU/meta'
3: I1114 01:36:48.750905 15983 status_update_manager.cpp:203] Recovering status update manager
3: I1114 01:36:48.751093 15989 containerizer.cpp:662] Recovering containerizer
3: I1114 01:36:48.752490 15978 provisioner.cpp:416] Provisioner recovery complete
3: I1114 01:36:48.752845 15973 slave.cpp:6432] Finished recovery
3: I1114 01:36:48.753886 15972 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:36:48.753916 15983 slave.cpp:1007] New master detected at master@172.17.0.4:41188
3: I1114 01:36:48.753973 15983 slave.cpp:1042] Detecting new master
3: I1114 01:36:48.757131 15984 process.cpp:3925] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/api/v1/resource_provider'
3: I1114 01:36:48.758479 15985 http.cpp:1185] HTTP POST for /slave(746)/api/v1/resource_provider from 172.17.0.4:35116
3: I1114 01:36:48.759063 15978 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:36:48.766346 15974 slave.cpp:883] Agent terminating
3: I1114 01:36:48.772132 15986 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 (51 ms)
3: [ RUN ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 01:36:48.778712 15965 cluster.cpp:162] Creating default 'local' authorizer
3: I1114 01:36:48.781209 15979 master.cpp:448] Master 0f5a665e-948d-4b30-8b79-58017d9e4cc6 (48c37892027e) started on 172.17.0.4:41188
3: I1114 01:36:48.781246 15979 master.cpp:450] 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/qQByPw/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="/usr/local/share/mesos/webui" --work_dir="/tmp/qQByPw/master" --zk_session_timeout="10secs"
3: I1114 01:36:48.781576 15979 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1114 01:36:48.781584 15979 master.cpp:505] Master only allowing authenticated agents to register
3: I1114 01:36:48.781587 15979 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1114 01:36:48.781592 15979 credentials.hpp:37] Loading credentials for authentication from '/tmp/qQByPw/credentials'
3: I1114 01:36:48.781891 15979 master.cpp:555] Using default 'crammd5' authenticator
3: I1114 01:36:48.782042 15979 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1114 01:36:48.782196 15979 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1114 01:36:48.782305 15979 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1114 01:36:48.782403 15979 master.cpp:634] Authorization enabled
3: I1114 01:36:48.782562 15985 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1114 01:36:48.782583 15978 whitelist_watcher.cpp:77] No whitelist given
3: I1114 01:36:48.785297 15971 master.cpp:2213] Elected as the leading master!
3: I1114 01:36:48.785315 15971 master.cpp:1693] Recovering from registrar
3: I1114 01:36:48.785421 15975 registrar.cpp:347] Recovering registrar
3: I1114 01:36:48.785984 15975 registrar.cpp:391] Successfully fetched the registry (0B) in 528896ns
3: I1114 01:36:48.786108 15975 registrar.cpp:495] Applied 1 operations in 43849ns; attempting to update the registry
3: I1114 01:36:48.786643 15975 registrar.cpp:552] Successfully updated the registry in 476672ns
3: I1114 01:36:48.786751 15975 registrar.cpp:424] Successfully recovered registrar
3: I1114 01:36:48.787081 15984 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1114 01:36:48.787107 15988 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1114 01:36:48.791599 15965 process.cpp:3178] Attempted to spawn already running process files@172.17.0.4:41188
3: I1114 01:36:48.792460 15965 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 01:36:48.793001 15965 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1114 01:36:48.793118 15965 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1114 01:36:48.793150 15965 provisioner.cpp:255] Using default backend 'copy'
3: I1114 01:36:48.794930 15965 cluster.cpp:448] Creating default 'local' authorizer
3: I1114 01:36:48.796785 15988 slave.cpp:262] Mesos agent started on (747)@172.17.0.4:41188
3: I1114 01:36:48.796808 15988 slave.cpp:263] Flags at startup: --acls="" --agent_features="capabilities {
3: type: MULTI_ROLE
3: }
3: capabilities {
3: type: HIERARCHICAL_ROLE
3: }
3: capabilities {
3: type: RESERVATION_REFINEMENT
3: }
3: capabilities {
3: type: RESOURCE_PROVIDER
3: }
3: " --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_HClxNJ" --zk_session_timeout="10secs"
3: I1114 01:36:48.797241 15988 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/credential'
3: I1114 01:36:48.797360 15988 slave.cpp:295] Agent using credential for: test-principal
3: I1114 01:36:48.797376 15988 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_X79wLW/http_credentials'
3: I1114 01:36:48.797556 15988 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 01:36:48.798835 15988 slave.cpp:593] 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"}]
3: I1114 01:36:48.799024 15988 slave.cpp:601] Agent attributes: [ ]
3: I1114 01:36:48.799036 15988 slave.cpp:610] Agent hostname: 48c37892027e
3: I1114 01:36:48.799157 15971 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:36:48.800668 15981 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_HClxNJ/meta'
3: I1114 01:36:48.800907 15989 status_update_manager.cpp:203] Recovering status update manager
3: I1114 01:36:48.801095 15969 containerizer.cpp:662] Recovering containerizer
3: I1114 01:36:48.802165 15972 provisioner.cpp:416] Provisioner recovery complete
3: I1114 01:36:48.802386 15971 slave.cpp:6432] Finished recovery
3: I1114 01:36:48.802979 15974 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:36:48.803025 15971 slave.cpp:1007] New master detected at master@172.17.0.4:41188
3: I1114 01:36:48.803119 15971 slave.cpp:1042] Detecting new master
3: I1114 01:36:48.804317 15981 slave.cpp:1069] Authenticating with master master@172.17.0.4:41188
3: I1114 01:36:48.804370 15981 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1114 01:36:48.804610 15977 authenticatee.cpp:121] Creating new client SASL connection
3: I1114 01:36:48.804878 15986 master.cpp:8285] Authenticating slave(747)@172.17.0.4:41188
3: I1114 01:36:48.804965 15989 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1374)@172.17.0.4:41188
3: I1114 01:36:48.805204 15970 authenticator.cpp:98] Creating new server SASL connection
3: I1114 01:36:48.805397 15984 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1114 01:36:48.805419 15984 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1114 01:36:48.805512 15975 authenticator.cpp:204] Received SASL authentication start
3: I1114 01:36:48.805559 15975 authenticator.cpp:326] Authentication requires more steps
3: I1114 01:36:48.805660 15967 authenticatee.cpp:259] Received SASL authentication step
3: I1114 01:36:48.805760 15985 authenticator.cpp:232] Received SASL authentication step
3: I1114 01:36:48.805788 15985 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '48c37892027e' server FQDN: '48c37892027e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1114 01:36:48.805799 15985 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1114 01:36:48.805832 15985 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1114 01:36:48.805847 15985 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '48c37892027e' server FQDN: '48c37892027e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1114 01:36:48.805855 15985 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:36:48.805860 15985 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:36:48.805871 15985 authenticator.cpp:318] Authentication success
3: I1114 01:36:48.805927 15978 authenticatee.cpp:299] Authentication success
3: I1114 01:36:48.806006 15982 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(747)@172.17.0.4:41188
3: I1114 01:36:48.806033 15969 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1374)@172.17.0.4:41188
3: I1114 01:36:48.806151 15978 slave.cpp:1161] Successfully authenticated with master master@172.17.0.4:41188
3: I1114 01:36:48.806370 15978 slave.cpp:1682] Will retry registration in 1043us if necessary
3: I1114 01:36:48.806548 15972 master.cpp:6032] Received register agent message from slave(747)@172.17.0.4:41188 (48c37892027e)
3: I1114 01:36:48.806578 15972 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1114 01:36:48.806942 15983 master.cpp:6092] Authorized registration of agent at slave(747)@172.17.0.4:41188 (48c37892027e)
3: I1114 01:36:48.807057 15983 master.cpp:6185] Registering agent at slave(747)@172.17.0.4:41188 (48c37892027e) with id 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0
3: I1114 01:36:48.807358 15976 registrar.cpp:495] Applied 1 operations in 63778ns; attempting to update the registry
3: I1114 01:36:48.807735 15971 slave.cpp:1682] Will retry registration in 31.184388ms if necessary
3: I1114 01:36:48.807847 15976 registrar.cpp:552] Successfully updated the registry in 432896ns
3: I1114 01:36:48.807862 15986 master.cpp:6026] Ignoring register agent message from slave(747)@172.17.0.4:41188 (48c37892027e) as registration is already in progress
3: I1114 01:36:48.808004 15989 master.cpp:6232] Admitted agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e)
3: I1114 01:36:48.808584 15984 slave.cpp:1207] Registered with master master@172.17.0.4:41188; given agent ID 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0
3: I1114 01:36:48.808683 15987 status_update_manager.cpp:184] Resuming sending status updates
3: I1114 01:36:48.808516 15989 master.cpp:6263] Registered agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) 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"}]
3: I1114 01:36:48.808814 15975 hierarchical.cpp:593] Added agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 (48c37892027e) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 01:36:48.808851 15984 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_HClxNJ/meta/slaves/0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0/slave.info'
3: I1114 01:36:48.809065 15975 hierarchical.cpp:1450] Performed allocation for 1 agents in 137131ns
3: I1114 01:36:48.809162 15984 slave.cpp:1285] Forwarding total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:36:48.809214 15984 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1114 01:36:48.809702 15985 master.cpp:7051] Received update of agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:36:48.809748 15985 master.cpp:7064] Received update of agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) with total oversubscribed resources {}
3: I1114 01:36:48.809903 15985 master.cpp:7082] Ignoring update on agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) as it reports no changes
3: I1114 01:36:48.810047 15966 http_connection.hpp:221] New endpoint detected at http://172.17.0.4:41188/slave(747)/api/v1/resource_provider
3: I1114 01:36:48.812052 15981 http_connection.hpp:277] Connected with the remote endpoint at http://172.17.0.4:41188/slave(747)/api/v1/resource_provider
3: I1114 01:36:48.812840 15984 http_connection.hpp:129] Sending 1 call to http://172.17.0.4:41188/slave(747)/api/v1/resource_provider
3: I1114 01:36:48.813836 15985 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 01:36:48.815398 15988 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.4:35118
3: I1114 01:36:48.815655 15974 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:36:48.817735 15968 http_connection.hpp:129] Sending 3 call to http://172.17.0.4:41188/slave(747)/api/v1/resource_provider
3: I1114 01:36:48.818655 15987 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 01:36:48.819473 15989 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.4:35120
3: I1114 01:36:48.819859 15967 slave.cpp:6719] Handling resource provider message 'UPDATE_TOTAL_RESOURCES: b2fc6c24-0d94-4289-95a5-678e00ee61bd disk[RAW]:200'
3: I1114 01:36:48.819960 15967 slave.cpp:6764] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:36:48.820852 15984 master.cpp:7051] Received update of agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:36:48.822043 15965 scheduler.cpp:190] Version: 1.5.0
3: I1114 01:36:48.822371 15974 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
3: I1114 01:36:48.822559 15983 hierarchical.cpp:660] Agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 (48c37892027e) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:36:48.822773 15986 scheduler.cpp:496] New master detected at master@172.17.0.4:41188
3: I1114 01:36:48.822793 15986 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
3: I1114 01:36:48.822911 15983 hierarchical.cpp:1450] Performed allocation for 1 agents in 190385ns
3: I1114 01:36:48.825866 15985 scheduler.cpp:387] Connected with the master at http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.826771 15977 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.828014 15989 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:36:48.829107 15978 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:35126
3: I1114 01:36:48.829339 15978 master.cpp:2613] Received subscription request for HTTP framework 'default'
3: I1114 01:36:48.829380 15978 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1114 01:36:48.829862 15984 master.cpp:2748] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 01:36:48.830620 15968 hierarchical.cpp:303] Added framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000
3: I1114 01:36:48.831156 15981 scheduler.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.831493 15981 scheduler.cpp:741] Enqueuing event HEARTBEAT received from http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.832033 15968 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.303365ms
3: I1114 01:36:48.832624 15974 master.cpp:8115] Sending 1 offers to framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 (default)
3: I1114 01:36:48.834287 15983 scheduler.cpp:741] Enqueuing event OFFERS received from http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.835750 15971 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.4:41188/master/api/v1/scheduler
3: I1114 01:36:48.836865 15977 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:36:48.837846 15984 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:35128
3: I1114 01:36:48.838770 15984 master.cpp:10017] Removing offer 0f5a665e-948d-4b30-8b79-58017d9e4cc6-O0
3: I1114 01:36:48.838874 15984 master.cpp:4228] Processing ACCEPT call for offers: [ 0f5a665e-948d-4b30-8b79-58017d9e4cc6-O0 ] on agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e) for framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 (default)
3: I1114 01:36:48.839503 15984 master.cpp:5293] Processing CREATE_BLOCK operation with source disk(allocated: *)[RAW]:200 from framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 (default) to agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e)
3: I1114 01:36:48.840076 15984 master.cpp:9900] Sending offer operation dhM ÿ¸'¾í[× to agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 at slave(747)@172.17.0.4:41188 (48c37892027e)
3: I1114 01:36:48.841051 15975 hierarchical.cpp:1125] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200, allocated: disk(allocated: *)[RAW]:200) on agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 from framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000
3: I1114 01:36:48.841112 15975 hierarchical.cpp:1171] Framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 filtered agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 for 5secs
3: I1114 01:36:48.842536 15988 http_connection.hpp:129] Sending 2 call to http://172.17.0.4:41188/slave(747)/api/v1/resource_provider
3: I1114 01:36:48.843299 15974 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 01:36:48.881867 15984 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.4:35120
3: I1114 01:36:48.882691 15986 slave.cpp:6719] Handling resource provider message 'UPDATE_OFFER_OPERATION_STATUS: {"framework_id":{"value":"0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"b2fc6c24-0d94-4289-95a5-678e00ee61bd"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"latest_status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"b2fc6c24-0d94-4289-95a5-678e00ee61bd"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"ZIOTlwFoTQyH\/7gnvu1b1w=="}'
3: I1114 01:36:48.883070 15986 slave.cpp:6893] Updating the state of offer operation '' (uuid: dhM ÿ¸'¾í[×) of framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 01:36:48.883412 15986 slave.cpp:6817] Forwarding status update of offer operation '' (uuid: 64839397-0168-4d0c-87ff-b827beed5bd7) for framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000
3: I1114 01:36:48.883980 15973 master.cpp:9698] Updating the state of offer operation '' (uuid: 64839397-0168-4d0c-87ff-b827beed5bd7) of framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 01:36:48.884403 15973 master.cpp:11027] CHECK_SOME(resources): cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 does not contain disk(allocated: *)[RAW]:200
3: *** Check failure stack trace: ***
3: I1114 01:36:48.885715 15971 hierarchical.cpp:849] Updated allocation of framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000 on agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 from disk(allocated: *)[RAW]:200 to disk(allocated: *)[BLOCK]:200
3: I1114 01:36:48.886057 15971 hierarchical.cpp:1125] Recovered disk(allocated: *)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[BLOCK]:200, allocated: {}) on agent 0f5a665e-948d-4b30-8b79-58017d9e4cc6-S0 from framework 0f5a665e-948d-4b30-8b79-58017d9e4cc6-0000
3: I1114 01:36:48.896199 15979 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.190967ms
3: @ 0x2acdeaecaa53 google::LogMessage::SendToLog()
3: @ 0x2acdeaecaecf google::LogMessage::Flush()
3: @ 0x2acdeaece95d google::LogMessageFatal::~LogMessageFatal()
3: @ 0xa9ec97 _CheckFatal::~_CheckFatal()
3: @ 0x2acde7cbccbb mesos::internal::master::Slave::apply()
3: @ 0x2acde7cb2554 mesos::internal::master::Master::updateOfferOperation()
3: @ 0x2acde7c6358d mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x2acde7dd42b4 ProtobufProcess<>::_handlerM<>()
3: @ 0x2acde7dd4d9c _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x2acde7dd4c93 _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x2acde7dd4a17 std::_Function_handler<>::_M_invoke()
3: @ 0xce8310 std::function<>::operator()()
3: @ 0x2acde7cd9cc6 ProtobufProcess<>::visit()
3: @ 0x2acde7c71425 mesos::internal::master::Master::_visit()
3: @ 0x2acde7c70a44 mesos::internal::master::Master::visit()
3: @ 0x2acde7c71637 mesos::internal::master::Master::visit()
3: @ 0x2acde7db33be process::MessageEvent::visit()
3: @ 0xae66a1 process::ProcessBase::serve()
3: @ 0x2acdea477282 process::ProcessManager::resume()
3: @ 0x2acdea487311 process::ProcessManager::init_threads()::$_8::operator()()
3: @ 0x2acdea487255 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_8vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3: @ 0x2acdea487225 std::_Bind_simple<>::operator()()
3: @ 0x2acdea4871fc std::thread::_Impl<>::_M_run()
3: @ 0x2acdee7e7a60 (unknown)
3: @ 0x2acdeb0f7184 start_thread
3: @ 0x2acdef053ffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: Other292.87 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 312.47 sec
The following tests FAILED:
3 - MesosTests (OTHER_FAULT)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1510621680-9693
Untagged: mesos-1510621680-9693:latest
Deleted: sha256:446f3d64ca5b259bb238997008f9020fa6549855963d26916f90ad2c8debb09b
Deleted: sha256:d227d3f64a8ade8c178f55b0d90ccfeb920bf6554b29e84515732141d599d983
Deleted: sha256:c372cce0d29b0fa373b8717f4c1622d73913dcfd5de083cbdf773b3bd9de8e4f
Deleted: sha256:a91fe83c976db266a8ede98fee7edab90846b2ebdaa668c46ddc4fc69ab0bb28
Deleted: sha256:b1cba9b3f664e84ba7729318af4f7c1a1e390023144934d8d6c3c7c2e8072d9e
Deleted: sha256:b94bcc9c77664cd019dd021f8b7fb7867eec0ce1ed02d0b059394c8ac55cc5f8
Deleted: sha256:a2ddaaac8c4e3d26b5c74043fa1433856016d69f8862501464172135a586a4af
Deleted: sha256:a719d86347b0e7e270ef4868b34db61ffe6c902c8ca20a15763307b70b72911f
Deleted: sha256:fd14039c1c4c08fdde0060e02474b07165bd9f8196d01d71c15d4146b46d7129
Deleted: sha256:db149cf1c7f4598c3e855264d4f5b01bede2a2aaa29179b1a43c38edd2128dad
Deleted: sha256:df1b5d3e077430a1f0251b34ccd2a39b19a9bcfe96580ea97d1ca2c8cc15590b
Deleted: sha256:3ef6da32f000fb38a15d19893dabc19c4428fe126af3b2922e38bdaca6b1e6de
Deleted: sha256:13e93d18424cd7c9ea978fd70d62c1c094a62a48aec2521838c5899478b13c9e
Deleted: sha256:3955973f5a29ae43b3f7b25f85fb94e09b1c1994c4a8167137ea223c05aab855
Deleted: sha256:5774d6ad9bbca6b44e96e7f6d74f68967ef8514aa0ee7dff90987d376c544805
Deleted: sha256:4826a337b75e237392ae856f6974b151800376dc89d394d5f341fd3ca4fde855
Deleted: sha256:7538f0ca45a4b6c8bd2a3e46825ffeb225916b13e0eb16add94f410215103d45
Deleted: sha256:1c4f20349b300365bf0a942389d08cb7f84d6db7dc3aa04172f9b7c2b3d17f75
Deleted: sha256:affdd38f0a0360a8eaa4b62a14e249317b3d319beea874c3c524572cac07e2c7
Deleted: sha256:28de99ad1d7df074cfdf74f7fdb4bf088729d2b1ca496eef178a40394785b428
Deleted: sha256:2b898fa8f1c05edd27e9be9724bb21f7b498ea002d4420420747014977fb0b72
Deleted: sha256:44a316458b709737bb5f5ab56ab330663a8d5745df5d1c2b26a497fbdd67f5af
Deleted: sha256:42a042538f107e3f11fa275a3a4a7bc263c183fe38c1fd3ff40659195f61f2a0
Deleted: sha256:22c86a97838165b470b03c84f461ad1697887496359758f64bc9097e863b5b28
Deleted: sha256:22df7620a6e45203b340b0283b10ae540b27d6d9225e8814e0206ec5cd0aef35
Deleted: sha256:5e52081a25c9890944b56e618d9986014b01f97129d1e6d4bc1c3cd782e35f6c
Deleted: sha256:735c936877ca7879ad826a426832abe9fc980b343d036c8b1d476d4dc5901873
Deleted: sha256:abfd2854d5b008bf427a9491de90bc07c8913a3c1442a2d30c2e1918e35f2e13
Deleted: sha256:6657d2ac90076658f14efbbdb58e7b167333b382d3a63a948c498f5291ad5665
Deleted: sha256:7a907f56f8badff4fc671a79df0fdf23b4211850702952949c216683faf5d1c8
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4455
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4455/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4452
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4452/display/redirect>
------------------------------------------
[...truncated 27.04 MB...]
3: I1114 02:34:39.113013 15966 slave.cpp:593] 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"}]
3: I1114 02:34:39.113342 15966 slave.cpp:601] Agent attributes: [ ]
3: I1114 02:34:39.113356 15966 slave.cpp:610] Agent hostname: 7ca2192713be
3: I1114 02:34:39.113512 15982 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:34:39.116022 15979 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_Jsb1jH/meta'
3: I1114 02:34:39.116358 15976 status_update_manager.cpp:203] Recovering status update manager
3: I1114 02:34:39.116551 15967 containerizer.cpp:662] Recovering containerizer
3: I1114 02:34:39.117885 15983 provisioner.cpp:416] Provisioner recovery complete
3: I1114 02:34:39.118157 15985 slave.cpp:6432] Finished recovery
3: I1114 02:34:39.118876 15976 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:34:39.118939 15984 slave.cpp:1007] New master detected at master@172.17.0.3:42601
3: I1114 02:34:39.119038 15984 slave.cpp:1042] Detecting new master
3: I1114 02:34:39.121557 15971 process.cpp:3925] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/api/v1/resource_provider'
3: I1114 02:34:39.122854 15978 http.cpp:1185] HTTP POST for /slave(746)/api/v1/resource_provider from 172.17.0.3:59784
3: I1114 02:34:39.123361 15987 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 02:34:39.131497 15963 slave.cpp:883] Agent terminating
3: I1114 02:34:39.137595 15963 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 (54 ms)
3: [ RUN ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 02:34:39.144062 15963 cluster.cpp:162] Creating default 'local' authorizer
3: I1114 02:34:39.146817 15972 master.cpp:448] Master 16bb6407-1ae6-4730-a008-15daabdaaf61 (7ca2192713be) started on 172.17.0.3:42601
3: I1114 02:34:39.146858 15972 master.cpp:450] 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/31k0Zy/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="/usr/local/share/mesos/webui" --work_dir="/tmp/31k0Zy/master" --zk_session_timeout="10secs"
3: I1114 02:34:39.147205 15972 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1114 02:34:39.147212 15972 master.cpp:505] Master only allowing authenticated agents to register
3: I1114 02:34:39.147215 15972 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1114 02:34:39.147220 15972 credentials.hpp:37] Loading credentials for authentication from '/tmp/31k0Zy/credentials'
3: I1114 02:34:39.147533 15972 master.cpp:555] Using default 'crammd5' authenticator
3: I1114 02:34:39.147703 15972 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1114 02:34:39.147871 15972 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1114 02:34:39.147977 15972 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1114 02:34:39.148077 15972 master.cpp:634] Authorization enabled
3: I1114 02:34:39.148252 15982 whitelist_watcher.cpp:77] No whitelist given
3: I1114 02:34:39.148258 15987 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1114 02:34:39.151640 15966 master.cpp:2213] Elected as the leading master!
3: I1114 02:34:39.151662 15966 master.cpp:1693] Recovering from registrar
3: I1114 02:34:39.151760 15978 registrar.cpp:347] Recovering registrar
3: I1114 02:34:39.152345 15978 registrar.cpp:391] Successfully fetched the registry (0B) in 555008ns
3: I1114 02:34:39.152477 15978 registrar.cpp:495] Applied 1 operations in 46460ns; attempting to update the registry
3: I1114 02:34:39.153028 15978 registrar.cpp:552] Successfully updated the registry in 492032ns
3: I1114 02:34:39.153129 15978 registrar.cpp:424] Successfully recovered registrar
3: I1114 02:34:39.153493 15967 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1114 02:34:39.153538 15964 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1114 02:34:39.160058 15963 process.cpp:3178] Attempted to spawn already running process files@172.17.0.3:42601
3: I1114 02:34:39.161262 15963 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 02:34:39.162044 15963 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1114 02:34:39.162175 15963 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1114 02:34:39.162216 15963 provisioner.cpp:255] Using default backend 'copy'
3: I1114 02:34:39.164412 15963 cluster.cpp:448] Creating default 'local' authorizer
3: I1114 02:34:39.166811 15964 slave.cpp:262] Mesos agent started on (747)@172.17.0.3:42601
3: I1114 02:34:39.166846 15964 slave.cpp:263] Flags at startup: --acls="" --agent_features="capabilities {
3: type: MULTI_ROLE
3: }
3: capabilities {
3: type: HIERARCHICAL_ROLE
3: }
3: capabilities {
3: type: RESERVATION_REFINEMENT
3: }
3: capabilities {
3: type: RESOURCE_PROVIDER
3: }
3: " --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO" --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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_jFEYDb" --zk_session_timeout="10secs"
3: I1114 02:34:39.167294 15964 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/credential'
3: I1114 02:34:39.167511 15964 slave.cpp:295] Agent using credential for: test-principal
3: I1114 02:34:39.167531 15964 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_dwoYhO/http_credentials'
3: I1114 02:34:39.167744 15964 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 02:34:39.169121 15964 slave.cpp:593] 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"}]
3: I1114 02:34:39.169323 15964 slave.cpp:601] Agent attributes: [ ]
3: I1114 02:34:39.169333 15964 slave.cpp:610] Agent hostname: 7ca2192713be
3: I1114 02:34:39.169457 15966 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:34:39.171288 15975 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_jFEYDb/meta'
3: I1114 02:34:39.171615 15986 status_update_manager.cpp:203] Recovering status update manager
3: I1114 02:34:39.171820 15971 containerizer.cpp:662] Recovering containerizer
3: I1114 02:34:39.173213 15977 provisioner.cpp:416] Provisioner recovery complete
3: I1114 02:34:39.173491 15966 slave.cpp:6432] Finished recovery
3: I1114 02:34:39.174304 15964 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:34:39.174340 15968 slave.cpp:1007] New master detected at master@172.17.0.3:42601
3: I1114 02:34:39.174537 15968 slave.cpp:1042] Detecting new master
3: I1114 02:34:39.180851 15979 slave.cpp:1069] Authenticating with master master@172.17.0.3:42601
3: I1114 02:34:39.180974 15979 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1114 02:34:39.181294 15984 authenticatee.cpp:121] Creating new client SASL connection
3: I1114 02:34:39.181640 15986 master.cpp:8285] Authenticating slave(747)@172.17.0.3:42601
3: I1114 02:34:39.181744 15965 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1376)@172.17.0.3:42601
3: I1114 02:34:39.181995 15967 authenticator.cpp:98] Creating new server SASL connection
3: I1114 02:34:39.182307 15967 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1114 02:34:39.182338 15967 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1114 02:34:39.182540 15970 authenticator.cpp:204] Received SASL authentication start
3: I1114 02:34:39.182602 15970 authenticator.cpp:326] Authentication requires more steps
3: I1114 02:34:39.182729 15973 authenticatee.cpp:259] Received SASL authentication step
3: I1114 02:34:39.182858 15969 authenticator.cpp:232] Received SASL authentication step
3: I1114 02:34:39.182888 15969 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7ca2192713be' server FQDN: '7ca2192713be' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1114 02:34:39.182900 15969 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1114 02:34:39.182946 15969 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1114 02:34:39.182962 15969 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7ca2192713be' server FQDN: '7ca2192713be' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1114 02:34:39.182971 15969 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 02:34:39.182976 15969 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 02:34:39.182989 15969 authenticator.cpp:318] Authentication success
3: I1114 02:34:39.183063 15980 authenticatee.cpp:299] Authentication success
3: I1114 02:34:39.183147 15971 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(747)@172.17.0.3:42601
3: I1114 02:34:39.183197 15980 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1376)@172.17.0.3:42601
3: I1114 02:34:39.183367 15985 slave.cpp:1161] Successfully authenticated with master master@172.17.0.3:42601
3: I1114 02:34:39.183681 15985 slave.cpp:1682] Will retry registration in 10.356269ms if necessary
3: I1114 02:34:39.183887 15976 master.cpp:6032] Received register agent message from slave(747)@172.17.0.3:42601 (7ca2192713be)
3: I1114 02:34:39.183925 15976 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1114 02:34:39.184371 15981 master.cpp:6092] Authorized registration of agent at slave(747)@172.17.0.3:42601 (7ca2192713be)
3: I1114 02:34:39.184489 15981 master.cpp:6185] Registering agent at slave(747)@172.17.0.3:42601 (7ca2192713be) with id 16bb6407-1ae6-4730-a008-15daabdaaf61-S0
3: I1114 02:34:39.184878 15974 registrar.cpp:495] Applied 1 operations in 92145ns; attempting to update the registry
3: I1114 02:34:39.185531 15974 registrar.cpp:552] Successfully updated the registry in 579072ns
3: I1114 02:34:39.185720 15984 master.cpp:6232] Admitted agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be)
3: I1114 02:34:39.186472 15965 slave.cpp:1207] Registered with master master@172.17.0.3:42601; given agent ID 16bb6407-1ae6-4730-a008-15daabdaaf61-S0
3: I1114 02:34:39.186578 15970 status_update_manager.cpp:184] Resuming sending status updates
3: I1114 02:34:39.186342 15984 master.cpp:6263] Registered agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) 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"}]
3: I1114 02:34:39.186686 15967 hierarchical.cpp:593] Added agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 (7ca2192713be) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 02:34:39.186877 15965 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_jFEYDb/meta/slaves/16bb6407-1ae6-4730-a008-15daabdaaf61-S0/slave.info'
3: I1114 02:34:39.186990 15967 hierarchical.cpp:1450] Performed allocation for 1 agents in 158018ns
3: I1114 02:34:39.187342 15965 slave.cpp:1285] Forwarding total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 02:34:39.187413 15965 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1114 02:34:39.188241 15973 master.cpp:7051] Received update of agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 02:34:39.188323 15973 master.cpp:7064] Received update of agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) with total oversubscribed resources {}
3: I1114 02:34:39.188524 15987 http_connection.hpp:221] New endpoint detected at http://172.17.0.3:42601/slave(747)/api/v1/resource_provider
3: I1114 02:34:39.188621 15973 master.cpp:7082] Ignoring update on agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) as it reports no changes
3: I1114 02:34:39.190652 15964 http_connection.hpp:277] Connected with the remote endpoint at http://172.17.0.3:42601/slave(747)/api/v1/resource_provider
3: I1114 02:34:39.191521 15965 http_connection.hpp:129] Sending 1 call to http://172.17.0.3:42601/slave(747)/api/v1/resource_provider
3: I1114 02:34:39.192695 15977 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 02:34:39.193668 15981 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.3:59786
3: I1114 02:34:39.193956 15968 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 02:34:39.196357 15985 http_connection.hpp:129] Sending 3 call to http://172.17.0.3:42601/slave(747)/api/v1/resource_provider
3: I1114 02:34:39.197398 15978 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 02:34:39.198339 15979 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.3:59788
3: I1114 02:34:39.198784 15967 slave.cpp:6719] Handling resource provider message 'UPDATE_TOTAL_RESOURCES: 55860c78-4e1e-4cfa-951a-0cce7dc97087 disk[RAW]:200'
3: I1114 02:34:39.198909 15967 slave.cpp:6764] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:34:39.199757 15971 master.cpp:7051] Received update of agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:34:39.200860 15963 scheduler.cpp:190] Version: 1.5.0
3: I1114 02:34:39.200963 15973 hierarchical.cpp:660] Agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 (7ca2192713be) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:34:39.201164 15964 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
3: I1114 02:34:39.201418 15973 hierarchical.cpp:1450] Performed allocation for 1 agents in 183559ns
3: I1114 02:34:39.201591 15979 scheduler.cpp:496] New master detected at master@172.17.0.3:42601
3: I1114 02:34:39.201619 15979 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
3: I1114 02:34:39.204567 15983 scheduler.cpp:387] Connected with the master at http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.205622 15970 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.206929 15967 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 02:34:39.207995 15976 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:59790
3: I1114 02:34:39.208261 15976 master.cpp:2613] Received subscription request for HTTP framework 'default'
3: I1114 02:34:39.208299 15976 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1114 02:34:39.208818 15985 master.cpp:2748] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 02:34:39.209534 15975 hierarchical.cpp:303] Added framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000
3: I1114 02:34:39.210137 15972 scheduler.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.210505 15972 scheduler.cpp:741] Enqueuing event HEARTBEAT received from http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.210866 15975 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.212882ms
3: I1114 02:34:39.211472 15972 master.cpp:8115] Sending 1 offers to framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 (default)
3: I1114 02:34:39.213376 15973 scheduler.cpp:741] Enqueuing event OFFERS received from http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.214699 15980 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.3:42601/master/api/v1/scheduler
3: I1114 02:34:39.215986 15981 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 02:34:39.217139 15984 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:59792
3: I1114 02:34:39.218134 15984 master.cpp:10017] Removing offer 16bb6407-1ae6-4730-a008-15daabdaaf61-O0
3: I1114 02:34:39.218253 15984 master.cpp:4228] Processing ACCEPT call for offers: [ 16bb6407-1ae6-4730-a008-15daabdaaf61-O0 ] on agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be) for framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 (default)
3: I1114 02:34:39.218967 15984 master.cpp:5293] Processing CREATE_BLOCK operation with source disk(allocated: *)[RAW]:200 from framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 (default) to agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be)
3: I1114 02:34:39.219581 15984 master.cpp:9900] Sending offer operation Ö®T Gu½BõSC to agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 at slave(747)@172.17.0.3:42601 (7ca2192713be)
3: I1114 02:34:39.220638 15965 hierarchical.cpp:1125] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200, allocated: disk(allocated: *)[RAW]:200) on agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 from framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000
3: I1114 02:34:39.220705 15965 hierarchical.cpp:1171] Framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 filtered agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 for 5secs
3: I1114 02:34:39.222419 15975 http_connection.hpp:129] Sending 2 call to http://172.17.0.3:42601/slave(747)/api/v1/resource_provider
3: I1114 02:34:39.223449 15972 process.cpp:3925] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 02:34:39.261922 15984 http.cpp:1185] HTTP POST for /slave(747)/api/v1/resource_provider from 172.17.0.3:59788
3: I1114 02:34:39.262662 15967 slave.cpp:6719] Handling resource provider message 'UPDATE_OFFER_OPERATION_STATUS: {"framework_id":{"value":"16bb6407-1ae6-4730-a008-15daabdaaf61-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"55860c78-4e1e-4cfa-951a-0cce7dc97087"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"latest_status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"55860c78-4e1e-4cfa-951a-0cce7dc97087"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"1oeuVAmfR3WWvUIBGfVTQw=="}'
3: I1114 02:34:39.263017 15967 slave.cpp:6893] Updating the state of offer operation '' (uuid: Ö®T Gu½BõSC) of framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 02:34:39.263345 15967 slave.cpp:6817] Forwarding status update of offer operation '' (uuid: d687ae54-099f-4775-96bd-420119f55343) for framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000
3: I1114 02:34:39.263851 15976 master.cpp:9698] Updating the state of offer operation '' (uuid: d687ae54-099f-4775-96bd-420119f55343) of framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 02:34:39.264152 15976 master.cpp:11027] CHECK_SOME(resources): cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 does not contain disk(allocated: *)[RAW]:200
3: *** Check failure stack trace: ***
3: @ 0x2afb83ba7a53 google::LogMessage::SendToLog()
3: @ 0x2afb83ba7ecf google::LogMessage::Flush()
3: @ 0x2afb83bab95d google::LogMessageFatal::~LogMessageFatal()
3: I1114 02:34:39.265645 15980 hierarchical.cpp:849] Updated allocation of framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000 on agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 from disk(allocated: *)[RAW]:200 to disk(allocated: *)[BLOCK]:200
3: I1114 02:34:39.266182 15980 hierarchical.cpp:1125] Recovered disk(allocated: *)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[BLOCK]:200, allocated: {}) on agent 16bb6407-1ae6-4730-a008-15daabdaaf61-S0 from framework 16bb6407-1ae6-4730-a008-15daabdaaf61-0000
3: @ 0xa9ec97 _CheckFatal::~_CheckFatal()
3: I1114 02:34:39.276633 15968 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.301225ms
3: @ 0x2afb80999cbb mesos::internal::master::Slave::apply()
3: @ 0x2afb8098f554 mesos::internal::master::Master::updateOfferOperation()
3: @ 0x2afb8094058d mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x2afb80ab12b4 ProtobufProcess<>::_handlerM<>()
3: @ 0x2afb80ab1d9c _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x2afb80ab1c93 _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x2afb80ab1a17 std::_Function_handler<>::_M_invoke()
3: @ 0xce8310 std::function<>::operator()()
3: @ 0x2afb809b6cc6 ProtobufProcess<>::visit()
3: @ 0x2afb8094e425 mesos::internal::master::Master::_visit()
3: @ 0x2afb8094da44 mesos::internal::master::Master::visit()
3: @ 0x2afb8094e637 mesos::internal::master::Master::visit()
3: @ 0x2afb80a903be process::MessageEvent::visit()
3: @ 0xae66a1 process::ProcessBase::serve()
3: @ 0x2afb83154282 process::ProcessManager::resume()
3: @ 0x2afb83164311 process::ProcessManager::init_threads()::$_8::operator()()
3: @ 0x2afb83164255 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_8vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3: @ 0x2afb83164225 std::_Bind_simple<>::operator()()
3: @ 0x2afb831641fc std::thread::_Impl<>::_M_run()
3: @ 0x2afb874c4a60 (unknown)
3: @ 0x2afb83dd4184 start_thread
3: @ 0x2afb87d30ffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: Other310.04 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 329.17 sec
The following tests FAILED:
3 - MesosTests (OTHER_FAULT)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make: *** [check] Error 2
+ docker rmi mesos-1510625254-24153
Untagged: mesos-1510625254-24153:latest
Deleted: sha256:39253d8ba74af8c7ef229a91cab819d977c1410f57c5b613ec9273b96152520b
Deleted: sha256:b686f79be8707d62e32dcd269cc2be5f540782f114a903bf75a7f78e5ec808a4
Deleted: sha256:733ccf695c83b1e74a57053872bdd228d63ec7ce186e3925d8cb186525e010e9
Deleted: sha256:2cb654bf97d8b702b50cd123d8967ec6c9cc0f4c620d59bf374ee9fb3fa06941
Deleted: sha256:f8f24b76b6b3b54aca628adb886531e6f0dcdcf8dbf9a1b219a666797547b145
Deleted: sha256:ab1bc22ac7c85865d96013cc92af42278db7270d03e59aa686db26d43016070c
Deleted: sha256:d2425bc240bf457fdb027b05cf4fee68c73034598158ec23ce73d9a398414e0a
Deleted: sha256:c7c065e867d714c729ad5bef5d83ba1fcd8dba7bb8fc0a39a6d41ed6043d9a5d
Deleted: sha256:3ec298f78d9f1b4579b86f0a0338c92eed9302426e62ef2b3f343483a1519686
Deleted: sha256:bcce74e29c86e5437fd70adc3bbabf277e71f3b96e44db07ceeac859f2d64de1
Deleted: sha256:6b7ad7f666e32bf2fd33cbcfa1163ae52fef50e5221197bb86e7f2daaedb234d
Deleted: sha256:3a353ba349b9c6aa50d1ea21262d7b252192209e0f3ebf428d76b6a6394618e4
Deleted: sha256:835c59a387711906e3fc51ff573545301bdf0de4f62458334b0687c1165d55e4
Deleted: sha256:895a9c00aada2c78a8bc3571d7e65ff635cc73afe9e1879ba87293debb7c9f35
Deleted: sha256:1821a2167d67b456f1617a6fe52d6a641c11f2420e68009386ca7a082688ac6d
Deleted: sha256:7e1c39282366b99ebd9ee97dd2e10985ce23948c48d8e7e08b8154ea1374e253
Deleted: sha256:4694fba821686cc6951bfba5df3e9ab2241164e998ee89b93e9ceb1eacfee3fe
Deleted: sha256:dab41a317d018a9b09b9886399930630b05011cf8c2dc67eb8a7a287e5f17d21
Deleted: sha256:8012fff753e68635589710d16b3c453a0959b9784e265f8627cb5c4a519b2cee
Deleted: sha256:3bdfe9951a630e22514862153f253743f9b6d4fca75e01adce2d0e168f551790
Deleted: sha256:18559b3012b4a56f499224f5cbb4a6a67878ea2296a883775ae1eaa76c062d56
Deleted: sha256:fba2cf5154a6b30a3a3d3b7ce12e819e00ded13c113d2e5bc982fe30b71e6f71
Deleted: sha256:2d846f51a1abf299badc5c7e82762d631b43a9bb8052b17a83d3853ec84f7799
Deleted: sha256:61984447d1055b041747a16d1f694a3c7368695b955a164d13e0ca511b9c853a
Deleted: sha256:018e4ca8786a6def3256da540ca47f9700d79a5ad744c2536fa84a49d9272256
Deleted: sha256:9cde38dc6595b56202c2600e120b068a543a76129824bd96fad0228244627884
Deleted: sha256:b766060373df7c1a07801b8c134bde2fe1a66264285ba923aaa7d981ead59aaf
Deleted: sha256:0ddd1517bcd1ac561d45b7cb555b0cf0cd511d95a368988ebc23de403cc8d4fe
Deleted: sha256:64de86b47dfbab8a491be7db26bfd0c147dbe7f5f9bc97ac5922ae93af350db3
Deleted: sha256:e083970ed855bf7688276ae779bd6370f92d852b3051c8496001b5eed6b7304a
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user yujie.jay@gmail.com