I’ve reverted 776bfab969c4df6d1ecea67f8a5aedf1ec3bed83. On 14 November 2017 at 03:53, Apache Jenkins Server < [email protected]> wrote:
> See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL= > cmake,COMPILER=gcc,CONFIGURATION=--verbose%20-- > disable-libtool-wrappers%20--enable-libevent%20--enable- > ssl,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.82 MB...] > 3: I1114 02:53:06.946594 19961 status_update_manager.cpp:177] Pausing > sending status updates > 3: I1114 02:53:06.948072 19964 state.cpp:64] Recovering state from > '/tmp/ContentType_ResourceProviderManagerHttpApi > Test_AgentEndpoint_1_f4uH3U/meta' > 3: I1114 02:53:06.948371 19956 status_update_manager.cpp:203] Recovering > status update manager > 3: I1114 02:53:06.948536 19949 containerizer.cpp:662] Recovering > containerizer > 3: I1114 02:53:06.950001 19955 provisioner.cpp:416] Provisioner recovery > complete > 3: I1114 02:53:06.950423 19953 slave.cpp:6432] Finished recovery > 3: I1114 02:53:06.951320 19956 status_update_manager.cpp:177] Pausing > sending status updates > 3: I1114 02:53:06.951333 19954 slave.cpp:1007] New master detected at > [email protected]:33432 > 3: I1114 02:53:06.951396 19954 slave.cpp:1042] Detecting new master > 3: I1114 02:53:06.955152 19962 process.cpp:3925] Handling HTTP event for > process 'slave(750)' with path: '/slave(750)/api/v1/resource_provider' > 3: I1114 02:53:06.957485 19961 http.cpp:1185] HTTP POST for > /slave(750)/api/v1/resource_provider from 172.17.0.2:58848 > 3: I1114 02:53:06.958020 19947 manager.cpp:381] Subscribing resource > provider {"name":"test","type":"org.apache.mesos.rp.test"} > 3: I1114 02:53:06.964301 19945 slave.cpp:883] Agent terminating > 3: I1114 02:53:06.970345 19945 master.cpp:1151] Master terminating > 3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 > (53 ms) > 3: [ RUN ] ContentType/ResourceProviderManagerHttpApi > Test.ConvertResources/0 > 3: I1114 02:53:06.977787 19945 cluster.cpp:162] Creating default 'local' > authorizer > 3: I1114 02:53:06.980988 19969 master.cpp:448] Master > 56cf5864-f4d1-40e5-90da-a37eaf7646c6 (78aba094e6f9) started on > 172.17.0.2:33432 > 3: I1114 02:53:06.981014 19969 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/EoWqJ5/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/EoWqJ5/master" --zk_session_timeout="10secs" > 3: I1114 02:53:06.981478 19969 master.cpp:499] Master only allowing > authenticated frameworks to register > 3: I1114 02:53:06.981488 19969 master.cpp:505] Master only allowing > authenticated agents to register > 3: I1114 02:53:06.981494 19969 master.cpp:511] Master only allowing > authenticated HTTP frameworks to register > 3: I1114 02:53:06.981501 19969 credentials.hpp:37] Loading credentials for > authentication from '/tmp/EoWqJ5/credentials' > 3: I1114 02:53:06.981861 19969 master.cpp:555] Using default 'crammd5' > authenticator > 3: I1114 02:53:06.982045 19969 http.cpp:1045] Creating default 'basic' > HTTP authenticator for realm 'mesos-master-readonly' > 3: I1114 02:53:06.982215 19969 http.cpp:1045] Creating default 'basic' > HTTP authenticator for realm 'mesos-master-readwrite' > 3: I1114 02:53:06.982373 19969 http.cpp:1045] Creating default 'basic' > HTTP authenticator for realm 'mesos-master-scheduler' > 3: I1114 02:53:06.982528 19969 master.cpp:634] Authorization enabled > 3: I1114 02:53:06.982709 19950 hierarchical.cpp:171] Initialized > hierarchical allocator process > 3: I1114 02:53:06.982746 19960 whitelist_watcher.cpp:77] No whitelist given > 3: I1114 02:53:06.986054 19963 master.cpp:2213] Elected as the leading > master! > 3: I1114 02:53:06.986091 19963 master.cpp:1693] Recovering from registrar > 3: I1114 02:53:06.986253 19955 registrar.cpp:347] Recovering registrar > 3: I1114 02:53:06.986997 19955 registrar.cpp:391] Successfully fetched the > registry (0B) in 683776ns > 3: I1114 02:53:06.987125 19955 registrar.cpp:495] Applied 1 operations in > 32640ns; attempting to update the registry > 3: I1114 02:53:06.987735 19955 registrar.cpp:552] Successfully updated the > registry in 552192ns > 3: I1114 02:53:06.987848 19955 registrar.cpp:424] Successfully recovered > registrar > 3: I1114 02:53:06.988415 19946 master.cpp:1806] Recovered 0 agents from > the registry (129B); allowing 10mins for agents to re-register > 3: I1114 02:53:06.988430 19965 hierarchical.cpp:209] Skipping recovery of > hierarchical allocator: nothing to recover > 3: W1114 02:53:06.993947 19945 process.cpp:3178] Attempted to spawn > already running process [email protected]:33432 > 3: I1114 02:53:06.994899 19945 containerizer.cpp:301] Using isolation { > environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } > 3: W1114 02:53:06.995415 19945 backend.cpp:76] Failed to create 'aufs' > backend: AufsBackend requires root privileges > 3: W1114 02:53:06.995530 19945 backend.cpp:76] Failed to create 'bind' > backend: BindBackend requires root privileges > 3: I1114 02:53:06.995563 19945 provisioner.cpp:255] Using default backend > 'copy' > 3: I1114 02:53:06.997514 19945 cluster.cpp:448] Creating default 'local' > authorizer > 3: I1114 02:53:06.999739 19946 slave.cpp:262] Mesos agent started on (751)@ > 172.17.0.2:33432 > 3: I1114 02:53:06.999754 19946 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_Six4Gx/store/appc" > --authenticate_http_executors="true" --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_Six4Gx/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_ResourceProviderManagerHttpApi > Test_ConvertResources_0_Six4Gx/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_secret_key="/tmp/ContentType_ResourceProviderManagerHttpApi > Test_ConvertResources_0_Six4Gx/executor_secret_key" > --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ > ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Six4Gx/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_ResourceProviderManagerHttpApi > Test_ConvertResources_0_Six4Gx/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_Six4Gx" > --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_ResourceProviderManagerHttpApi > Test_ConvertResources_0_b5SeIO" --zk_session_timeout="10secs" > 3: I1114 02:53:07.000257 19946 credentials.hpp:86] Loading credential for > authentication from '/tmp/ContentType_ResourceProviderManagerHttpApi > Test_ConvertResources_0_Six4Gx/credential' > 3: I1114 02:53:07.000419 19946 slave.cpp:295] Agent using credential for: > test-principal > 3: I1114 02:53:07.000437 19946 credentials.hpp:37] Loading credentials for > authentication from '/tmp/ContentType_ResourceProviderManagerHttpApi > Test_ConvertResources_0_Six4Gx/http_credentials' > 3: I1114 02:53:07.000725 19946 http.cpp:1045] Creating default 'basic' > HTTP authenticator for realm 'mesos-agent-executor' > 3: I1114 02:53:07.000855 19946 http.cpp:1066] Creating default 'jwt' HTTP > authenticator for realm 'mesos-agent-executor' > 3: I1114 02:53:07.001065 19946 http.cpp:1045] Creating default 'basic' > HTTP authenticator for realm 'mesos-agent-readonly' > 3: I1114 02:53:07.001165 19946 http.cpp:1066] Creating default 'jwt' HTTP > authenticator for realm 'mesos-agent-readonly' > 3: I1114 02:53:07.002676 19946 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:53:07.002900 19946 slave.cpp:601] Agent attributes: [ ] > 3: I1114 02:53:07.002910 19946 slave.cpp:610] Agent hostname: 78aba094e6f9 > 3: I1114 02:53:07.003098 19953 status_update_manager.cpp:177] Pausing > sending status updates > 3: I1114 02:53:07.004681 19954 state.cpp:64] Recovering state from > '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ > b5SeIO/meta' > 3: I1114 02:53:07.004995 19954 status_update_manager.cpp:203] Recovering > status update manager > 3: I1114 02:53:07.005203 19954 containerizer.cpp:662] Recovering > containerizer > 3: I1114 02:53:07.006691 19962 provisioner.cpp:416] Provisioner recovery > complete > 3: I1114 02:53:07.007083 19951 slave.cpp:6432] Finished recovery > 3: I1114 02:53:07.007786 19946 status_update_manager.cpp:177] Pausing > sending status updates > 3: I1114 02:53:07.007787 19955 slave.cpp:1007] New master detected at > [email protected]:33432 > 3: I1114 02:53:07.007875 19955 slave.cpp:1042] Detecting new master > 3: I1114 02:53:07.014212 19958 slave.cpp:1069] Authenticating with master > [email protected]:33432 > 3: I1114 02:53:07.014333 19958 slave.cpp:1078] Using default CRAM-MD5 > authenticatee > 3: I1114 02:53:07.014644 19959 authenticatee.cpp:121] Creating new client > SASL connection > 3: I1114 02:53:07.015040 19967 master.cpp:8285] Authenticating slave(751)@ > 172.17.0.2:33432 > 3: I1114 02:53:07.015202 19949 authenticator.cpp:414] Starting > authentication session for crammd5-authenticatee(1383)@172.17.0.2:33432 > 3: I1114 02:53:07.015475 19966 authenticator.cpp:98] Creating new server > SASL connection > 3: I1114 02:53:07.015750 19969 authenticatee.cpp:213] Received SASL > authentication mechanisms: CRAM-MD5 > 3: I1114 02:53:07.015779 19969 authenticatee.cpp:239] Attempting to > authenticate with mechanism 'CRAM-MD5' > 3: I1114 02:53:07.015897 19950 authenticator.cpp:204] Received SASL > authentication start > 3: I1114 02:53:07.015971 19950 authenticator.cpp:326] Authentication > requires more steps > 3: I1114 02:53:07.016119 19948 authenticatee.cpp:259] Received SASL > authentication step > 3: I1114 02:53:07.016261 19952 authenticator.cpp:232] Received SASL > authentication step > 3: I1114 02:53:07.016293 19952 auxprop.cpp:109] Request to lookup > properties for user: 'test-principal' realm: '78aba094e6f9' server FQDN: > '78aba094e6f9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false > SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false > 3: I1114 02:53:07.016306 19952 auxprop.cpp:181] Looking up auxiliary > property '*userPassword' > 3: I1114 02:53:07.016355 19952 auxprop.cpp:181] Looking up auxiliary > property '*cmusaslsecretCRAM-MD5' > 3: I1114 02:53:07.016372 19952 auxprop.cpp:109] Request to lookup > properties for user: 'test-principal' realm: '78aba094e6f9' server FQDN: > '78aba094e6f9' SASL_AUXPROP_VERIFY_AGAINST_HASH: false > SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true > 3: I1114 02:53:07.016379 19952 auxprop.cpp:131] Skipping auxiliary > property '*userPassword' since SASL_AUXPROP_AUTHZID == true > 3: I1114 02:53:07.016384 19952 auxprop.cpp:131] Skipping auxiliary > property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true > 3: I1114 02:53:07.016396 19952 authenticator.cpp:318] Authentication > success > 3: I1114 02:53:07.016487 19960 authenticatee.cpp:299] Authentication > success > 3: I1114 02:53:07.016592 19954 master.cpp:8315] Successfully authenticated > principal 'test-principal' at slave(751)@172.17.0.2:33432 > 3: I1114 02:53:07.016675 19968 authenticator.cpp:432] Authentication > session cleanup for crammd5-authenticatee(1383)@172.17.0.2:33432 > 3: I1114 02:53:07.016803 19963 slave.cpp:1161] Successfully authenticated > with master [email protected]:33432 > 3: I1114 02:53:07.017132 19963 slave.cpp:1682] Will retry registration in > 18.870593ms if necessary > 3: I1114 02:53:07.017354 19953 master.cpp:6032] Received register agent > message from slave(751)@172.17.0.2:33432 (78aba094e6f9) > 3: I1114 02:53:07.017491 19953 master.cpp:3870] Authorizing agent with > principal 'test-principal' > 3: I1114 02:53:07.018110 19957 master.cpp:6092] Authorized registration of > agent at slave(751)@172.17.0.2:33432 (78aba094e6f9) > 3: I1114 02:53:07.018277 19957 master.cpp:6185] Registering agent at > slave(751)@172.17.0.2:33432 (78aba094e6f9) with id > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 > 3: I1114 02:53:07.018782 19964 registrar.cpp:495] Applied 1 operations in > 67922ns; attempting to update the registry > 3: I1114 02:53:07.019464 19964 registrar.cpp:552] Successfully updated the > registry in 613888ns > 3: I1114 02:53:07.019686 19959 master.cpp:6232] Admitted agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) > 3: I1114 02:53:07.020391 19949 slave.cpp:1207] Registered with master > [email protected]:33432; given agent ID 56cf5864-f4d1-40e5-90da- > a37eaf7646c6-S0 > 3: I1114 02:53:07.020484 19950 status_update_manager.cpp:184] Resuming > sending status updates > 3: I1114 02:53:07.020277 19959 master.cpp:6263] Registered agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) 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:53:07.020619 19966 hierarchical.cpp:593] Added agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 (78aba094e6f9) with cpus:2; > mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) > 3: I1114 02:53:07.020727 19949 slave.cpp:1227] Checkpointing SlaveInfo to > '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ > b5SeIO/meta/slaves/56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0/slave.info' > 3: I1114 02:53:07.020927 19966 hierarchical.cpp:1450] Performed allocation > for 1 agents in 141181ns > 3: I1114 02:53:07.021145 19949 slave.cpp:1285] Forwarding total resources > cpus:2; mem:1024; disk:1024; ports:[31000-32000] > 3: I1114 02:53:07.021217 19949 slave.cpp:1295] Forwarding total > oversubscribed resources {} > 3: I1114 02:53:07.021803 19949 master.cpp:7051] Received update of agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) with total resources cpus:2; mem:1024; disk:1024; > ports:[31000-32000] > 3: I1114 02:53:07.021860 19949 master.cpp:7064] Received update of agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) with total oversubscribed resources {} > 3: I1114 02:53:07.022055 19949 master.cpp:7082] Ignoring update on agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) as it reports no changes > 3: I1114 02:53:07.022234 19947 http_connection.hpp:221] New endpoint > detected at http://172.17.0.2:33432/slave(751)/api/v1/resource_provider > 3: I1114 02:53:07.024454 19955 http_connection.hpp:277] Connected with the > remote endpoint at http://172.17.0.2:33432/slave( > 751)/api/v1/resource_provider > 3: I1114 02:53:07.025409 19948 http_connection.hpp:129] Sending 1 call to > http://172.17.0.2:33432/slave(751)/api/v1/resource_provider > 3: I1114 02:53:07.026854 19968 process.cpp:3925] Handling HTTP event for > process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider' > 3: I1114 02:53:07.028084 19963 http.cpp:1185] HTTP POST for > /slave(751)/api/v1/resource_provider from 172.17.0.2:58852 > 3: I1114 02:53:07.028414 19951 manager.cpp:381] Subscribing resource > provider {"name":"test","type":"org.apache.mesos.rp.test"} > 3: I1114 02:53:07.031831 19947 http_connection.hpp:129] Sending 3 call to > http://172.17.0.2:33432/slave(751)/api/v1/resource_provider > 3: I1114 02:53:07.033026 19958 process.cpp:3925] Handling HTTP event for > process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider' > 3: I1114 02:53:07.034543 19969 http.cpp:1185] HTTP POST for > /slave(751)/api/v1/resource_provider from 172.17.0.2:58850 > 3: I1114 02:53:07.035089 19967 slave.cpp:6719] Handling resource provider > message 'UPDATE_TOTAL_RESOURCES: 737fa65c-a99a-443b-a7da-66ca74923908 > disk[RAW]:200' > 3: I1114 02:53:07.035246 19967 slave.cpp:6764] Forwarding new total > resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 > 3: I1114 02:53:07.036166 19960 master.cpp:7051] Received update of agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) with total resources cpus:2; mem:1024; disk:1024; > ports:[31000-32000]; disk[RAW]:200 > 3: I1114 02:53:07.037621 19945 scheduler.cpp:190] Version: 1.5.0 > 3: I1114 02:53:07.037796 19949 hierarchical.cpp:660] Agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 (78aba094e6f9) updated with total > resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 > 3: I1114 02:53:07.037957 19951 scheduler.cpp:313] Using default 'basic' > HTTP authenticatee > 3: I1114 02:53:07.038141 19949 hierarchical.cpp:1450] Performed allocation > for 1 agents in 151824ns > 3: I1114 02:53:07.038491 19965 scheduler.cpp:496] New master detected at > [email protected]:33432 > 3: I1114 02:53:07.038542 19965 scheduler.cpp:505] Waiting for 0ns before > initiating a re-(connection) attempt with the master > 3: I1114 02:53:07.041494 19967 scheduler.cpp:387] Connected with the > master at http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.042599 19964 scheduler.cpp:249] Sending SUBSCRIBE call > to http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.044898 19946 process.cpp:3925] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > 3: I1114 02:53:07.046114 19948 http.cpp:1185] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:58856 > 3: I1114 02:53:07.046371 19948 master.cpp:2613] Received subscription > request for HTTP framework 'default' > 3: I1114 02:53:07.046479 19948 master.cpp:2278] Authorizing framework > principal 'test-principal' to receive offers for roles '{ * }' > 3: I1114 02:53:07.047006 19952 master.cpp:2748] Subscribing framework > 'default' with checkpointing disabled and capabilities [ > RESERVATION_REFINEMENT ] > 3: I1114 02:53:07.047770 19963 hierarchical.cpp:303] Added framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > 3: I1114 02:53:07.048667 19950 scheduler.cpp:741] Enqueuing event > SUBSCRIBED received from http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.049100 19950 scheduler.cpp:741] Enqueuing event > HEARTBEAT received from http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.049335 19963 hierarchical.cpp:1450] Performed allocation > for 1 agents in 1.402777ms > 3: I1114 02:53:07.050079 19954 master.cpp:8115] Sending 1 offers to > framework 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 (default) > 3: I1114 02:53:07.051934 19957 scheduler.cpp:741] Enqueuing event OFFERS > received from http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.053679 19961 scheduler.cpp:249] Sending ACCEPT call to > http://172.17.0.2:33432/master/api/v1/scheduler > 3: I1114 02:53:07.055368 19966 process.cpp:3925] Handling HTTP event for > process 'master' with path: '/master/api/v1/scheduler' > 3: I1114 02:53:07.056813 19952 http.cpp:1185] HTTP POST for > /master/api/v1/scheduler from 172.17.0.2:58854 > 3: I1114 02:53:07.057857 19952 master.cpp:10017] Removing offer > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-O0 > 3: I1114 02:53:07.057960 19952 master.cpp:4228] Processing ACCEPT call for > offers: [ 56cf5864-f4d1-40e5-90da-a37eaf7646c6-O0 ] on agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) for framework 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > (default) > 3: I1114 02:53:07.058682 19952 master.cpp:5293] Processing CREATE_BLOCK > operation with source disk(allocated: *)[RAW]:200 from framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 (default) to agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at slave(751)@172.17.0.2:33432 > (78aba094e6f9) > 3: I1114 02:53:07.059255 19952 master.cpp:9900] Sending offer operation > r2Í; µF3‡¬”y±‡¨¤ to agent 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 at > slave(751)@172.17.0.2:33432 (78aba094e6f9) > 3: I1114 02:53:07.060523 19957 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 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 from framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > 3: I1114 02:53:07.060608 19957 hierarchical.cpp:1171] Framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 filtered agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 for 5secs > 3: I1114 02:53:07.062851 19966 http_connection.hpp:129] Sending 2 call to > http://172.17.0.2:33432/slave(751)/api/v1/resource_provider > 3: I1114 02:53:07.063822 19951 process.cpp:3925] Handling HTTP event for > process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider' > 3: I1114 02:53:07.107501 19953 http.cpp:1185] HTTP POST for > /slave(751)/api/v1/resource_provider from 172.17.0.2:58850 > 3: I1114 02:53:07.108409 19955 slave.cpp:6719] Handling resource provider > message 'UPDATE_OFFER_OPERATION_STATUS: {"framework_id":{"value":" > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000"},"status":{ > "state":"OFFER_OPERATION_FINISHED","converted_ > resources":[{"provider_id":{"value":"737fa65c-a99a-443b- > a7da-66ca74923908"},"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":" > 737fa65c-a99a-443b-a7da-66ca74923908"},"name":"disk"," > type":"SCALAR","scalar":{"value":200.0},"allocation_ > info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]}," > operation_uuid":"cjLNO4+1RjOHrJR5sYeopA=="}' > 3: I1114 02:53:07.108831 19955 slave.cpp:6893] Updating the state of offer > operation '' (uuid: r2Í; µF3‡¬”y±‡¨¤) of framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > (latest state: OFFER_OPERATION_FINISHED, status update state: > OFFER_OPERATION_FINISHED) > 3: I1114 02:53:07.109284 19955 slave.cpp:6817] Forwarding status update of > offer operation '' (uuid: 7232cd3b-8fb5-4633-87ac-9479b187a8a4) for > framework 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > 3: I1114 02:53:07.109923 19957 master.cpp:9698] Updating the state of > offer operation '' (uuid: 7232cd3b-8fb5-4633-87ac-9479b187a8a4) of > framework 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 (latest state: > OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED) > 3: F1114 02:53:07.110375 19957 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: @ 0x2ba43f3dc9fd google::LogMessage::Fail() > 3: @ 0x2ba43f3de89d google::LogMessage::SendToLog() > 3: @ 0x2ba43f3dc5ec google::LogMessage::Flush() > 3: @ 0x2ba43f3df1be google::LogMessageFatal::~LogMessageFatal() > 3: I1114 02:53:07.112073 19965 hierarchical.cpp:849] Updated allocation of > framework 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 on agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 from disk(allocated: *)[RAW]:200 > to disk(allocated: *)[BLOCK]:200 > 3: I1114 02:53:07.112476 19965 hierarchical.cpp:1125] Recovered > disk(allocated: *)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; > ports:[31000-32000]; disk[BLOCK]:200, allocated: {}) on agent > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-S0 from framework > 56cf5864-f4d1-40e5-90da-a37eaf7646c6-0000 > 3: I1114 02:53:07.117007 19959 hierarchical.cpp:1450] Performed allocation > for 1 agents in 1.96546ms > 3: @ 0xc98678 _CheckFatal::~_CheckFatal() > 3: @ 0x2ba43c7413d1 mesos::internal::master::Slave::apply() > 3: @ 0x2ba43c737394 mesos::internal::master:: > Master::updateOfferOperation() > 3: @ 0x2ba43c7223a7 mesos::internal::master::Master:: > offerOperationStatusUpdate() > 3: @ 0x2ba43c786b45 ProtobufProcess<>::_handlerM<>() > 3: @ 0x2ba43c840b0f _ZNSt5_BindIFPFvPN5mesos8internal6mas > ter6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEE > RKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ > ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_ > OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE > 3: @ 0x2ba43c81ed46 _ZNSt5_BindIFPFvPN5mesos8internal6mas > ter6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEE > RKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ > ILi2EEEEclIJSD_SF_EvEET0_DpOT_ > 3: @ 0x2ba43c7f3c82 std::_Function_handler<>::_M_invoke() > 3: @ 0xe84ae3 std::function<>::operator()() > 3: @ 0x2ba43c76811c ProtobufProcess<>::visit() > 3: @ 0x2ba43c6f81c0 mesos::internal::master::Master::_visit() > 3: @ 0x2ba43c6f78d2 mesos::internal::master::Master::visit() > 3: @ 0x2ba43c74cf68 process::MessageEvent::visit() > 3: @ 0xcb24d2 process::ProcessBase::serve() > 3: @ 0x2ba43ee23c7d process::ProcessManager::resume() > 3: @ 0x2ba43ee200dc _ZZN7process14ProcessManager12i > nit_threadsEvENKUlvE_clEv > 3: @ 0x2ba43ee32404 _ZNSt12_Bind_simpleIFZN7process14ProcessMan > ager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE > 3: @ 0x2ba43ee3235b _ZNSt12_Bind_simpleIFZN7process14ProcessMan > ager12init_threadsEvEUlvE_vEEclEv > 3: @ 0x2ba43ee322f4 _ZNSt6thread5_ImplISt12_Bind_ > simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv > 3: @ 0x2ba441e12a60 (unknown) > 3: @ 0x2ba43f608184 start_thread > 3: @ 0x2ba44267effd (unknown) > 3/3 Test #3: MesosTests .......................***Exception: Other471.04 > sec > > 67% tests passed, 1 tests failed out of 3 > > Total Test time (real) = 514.37 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-1510625256-18842 > Untagged: mesos-1510625256-18842:latest > Deleted: sha256:d1892b9f5c403516c58ff845e2b270 > 7161a4c3611cdad47730bc75c558de84e2 > Deleted: sha256:6c4f2871cbe8448899913bbaeb47a8 > cd4742efbcde5673431eace14e7e57b239 > Deleted: sha256:99de6899a2a171a85034acfed5a4ac > e68b629d5f45ed0dabee29b2031f356adf > Deleted: sha256:327d5d20b026ecec5eebbf621c1a31 > fd6d26416e2a088bd28632dba576ed4dcb > Deleted: sha256:4fe943add9fdd4f321ff846706c39f > 137501ad41f310b2638fb2657efa8841ca > Deleted: sha256:945727d116337ce65f3fcef7ceb858 > 9076d2633e447f855b404d45a0e7c06fb1 > Deleted: sha256:c46e68e2a7dc3ddc5f7c6466b96b4c > 24cde4abb2bf52eadc2caf83866f4f3434 > Deleted: sha256:3b13cf80f255be0b45495a0874165c > 02db855d5b5b84afdfde48e81a760742ef > Deleted: sha256:be8391fd1d3884568ce0097c4ee3a1 > 8bc103baeb77472c4c9ce0833652fa6f04 > Deleted: sha256:4973213dd35afd755f2a7867b35c6b > 2442e4a2c5fec8ec9ba908b4140753a8ff > Deleted: sha256:873340b1d0e2f0c62e49761447a478 > 9bb87202963766c6148c7afef94dfdaa09 > Deleted: sha256:ad89a637bd87f107f84beceac20d2b > 88da6dedec807f0ae4ff7de0829e025421 > Deleted: sha256:419f03c6c4e98ed6b8b5359716b6af > 6e3432a259ea4cce91be06ae6e482a2b7e > Deleted: sha256:2a455152552f8a2f8f9b7871a74834 > 235f9d894497931c3e67b3a6470b4ed01a > Deleted: sha256:626aadc8ec2d50dd27ca1845fd63bb > d8380b303fba7d0ca1bbac559ecdc07846 > Deleted: sha256:744d0f652cb14b258e93c5e8fc9b0f > 4db3fc91132edd66076c4c709803b6cee1 > Deleted: sha256:7009d6d382c25f0e628f4d2bc2218d > f70ca0e6a6e1026046972c852694dc9e0f > Deleted: sha256:6a38d234edebe52410678d6f9fd04a > 421a52f32b6bb10a65512ff8215fc115d9 > Deleted: sha256:402ab624987e19031cb39173254a39 > 275cfe38242f8f0650ca9ae57a542b6248 > Deleted: sha256:9eae2be8af28d803e3b013d19a719a > 699a214361d7debbef94fff905741f9bbd > Deleted: sha256:68d764c2d6ef62285b8aef3c6a16e0 > f213c58644194af49985a9b0591affe0f8 > Deleted: sha256:f49e951e96eb61ca38cb75b20533f4 > d6d27534ed9fcb4bf4d86bd1dad9a2a9e0 > Deleted: sha256:22a4192227177fbc6a2e51401c51c5 > 389d2f639be274c51104e8e5f41793a7c4 > Deleted: sha256:e7ec732d07c9b806b9a5f6d34cc288 > 9026f1913da069796f596d030e12dd5f17 > Deleted: sha256:4d36b376f85e6c23cbe82fa2813eee > 1ecb7ae84d574d0d5f1584efc7bf7613f3 > Deleted: sha256:00863748d409fefe5e0db6c12ee9b8 > e600da6f0780c784748f628a9ef878df87 > Deleted: sha256:937bb55093f04770d26c8c9df63cfc > f984e42b0e14ab598e03a80a224717ef99 > Deleted: sha256:c6604f1e3909a5de4b6718f077dfe0 > acbfe2013bdcfa5d8e3e630a0c7f84ba87 > Deleted: sha256:429369ba654b02f981aed437542d65 > 625544c5000f511aa25f46110cfb8a1138 > Deleted: sha256:29ea2892fc686f856bf342706ae8a6 > 43c3714f809b320ee0a06f7403c4a19f64 > Build step 'Execute shell' marked build as failure > Not sending mail to unregistered user [email protected] > Not sending mail to unregistered user [email protected] >
