builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1496334793.12 results: success (0) revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.117640) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.118463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.118872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.143645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.144161) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 09:33:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2017-06-01 09:33:13 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092477 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.263885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.264193) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019348 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:13.314830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 09:33:13.315168) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cac2fd43de81d44b36396704220996b0c4a39f1a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev cac2fd43de81d44b36396704220996b0c4a39f1a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 09:33:13,383 truncating revision to first 12 chars 2017-06-01 09:33:13,383 Setting DEBUG logging. 2017-06-01 09:33:13,383 attempt 1/10 2017-06-01 09:33:13,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cac2fd43de81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 09:33:14,466 unpacking tar archive at: mozilla-central-cac2fd43de81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 09:33:14.708025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:14.708344) ========= script_repo_revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:14.708704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:14.708964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:33:14.717896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-01 09:33:14.718256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:14 INFO - MultiFileLogger online at 20170601 09:33:14 in /builds/slave/test 09:33:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:33:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:14 INFO - {'append_to_log': False, 09:33:14 INFO - 'base_work_dir': '/builds/slave/test', 09:33:14 INFO - 'blob_upload_branch': 'Firefox', 09:33:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:14 INFO - 'branch': 'Firefox', 09:33:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:14 INFO - 'config_files': ('talos/linux_config.py',), 09:33:14 INFO - 'default_actions': ('clobber', 09:33:14 INFO - 'read-buildbot-config', 09:33:14 INFO - 'download-and-extract', 09:33:14 INFO - 'populate-webroot', 09:33:14 INFO - 'create-virtualenv', 09:33:14 INFO - 'install', 09:33:14 INFO - 'setup-mitmproxy', 09:33:14 INFO - 'run-tests'), 09:33:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:14 INFO - 'download_minidump_stackwalk': True, 09:33:14 INFO - 'download_symbols': 'ondemand', 09:33:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:14 INFO - 'gecko_profile': False, 09:33:14 INFO - 'gecko_profile_interval': 0, 09:33:14 INFO - 'installer_path': 'installer.exe', 09:33:14 INFO - 'log_level': 'info', 09:33:14 INFO - 'log_name': 'talos', 09:33:14 INFO - 'log_to_console': True, 09:33:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:14 INFO - 'opt_config_files': (), 09:33:14 INFO - 'pip_index': False, 09:33:14 INFO - 'suite': 'dromaeojs-e10s', 09:33:14 INFO - 'system_bits': '32', 09:33:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:14 INFO - 'title': 'talos-linux64-ix-036', 09:33:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:14 INFO - 'use_talos_json': True, 09:33:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:14 INFO - 'work_dir': 'build'} 09:33:14 INFO - [mozharness: 2017-06-01 16:33:14.889075Z] Running clobber step. 09:33:14 INFO - Running pre-action listener: _resource_record_pre_action 09:33:14 INFO - Running main action method: clobber 09:33:14 INFO - rmtree: /builds/slave/test/build 09:33:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:15 INFO - Running post-action listener: _resource_record_post_action 09:33:15 INFO - [mozharness: 2017-06-01 16:33:15.896062Z] Finished clobber step (success) 09:33:15 INFO - [mozharness: 2017-06-01 16:33:15.896163Z] Running read-buildbot-config step. 09:33:15 INFO - Running pre-action listener: _resource_record_pre_action 09:33:15 INFO - Running main action method: read_buildbot_config 09:33:15 INFO - Using buildbot properties: 09:33:15 INFO - { 09:33:15 INFO - "project": "", 09:33:15 INFO - "product": "firefox", 09:33:15 INFO - "who": "ryanvm@gmail.com", 09:33:15 INFO - "installer_path": "public/build/target.tar.bz2", 09:33:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:33:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:33:15 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:33:15 INFO - "stage_platform": "linux64-stylo", 09:33:15 INFO - "basedir": "/builds/slave/test", 09:33:15 INFO - "buildnumber": 127, 09:33:15 INFO - "platform": "ubuntu64_hw_stylo", 09:33:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:33:15 INFO - "slavebuilddir": "test", 09:33:15 INFO - "taskId": "HcHJFVABQ6eGKoSPh2PHSQ", 09:33:15 INFO - "branch": "mozilla-central", 09:33:15 INFO - "script_repo_revision": "production", 09:33:15 INFO - "revision": "cac2fd43de81d44b36396704220996b0c4a39f1a", 09:33:15 INFO - "slavename": "talos-linux64-ix-036", 09:33:15 INFO - "repo_path": "mozilla-central" 09:33:15 INFO - } 09:33:15 INFO - Finding installer, test and symbols from parent task. 09:33:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcHJFVABQ6eGKoSPh2PHSQ'}, attempt #1 09:33:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcHJFVABQ6eGKoSPh2PHSQ'}, attempt #1 09:33:16 INFO - Task dependencies: aZiu00IFQfi-S6xLljRYbw 09:33:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw'}, attempt #1 09:33:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 09:33:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/test_packages.json 09:33:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.crashreporter-symbols.zip 09:33:17 INFO - Running post-action listener: _resource_record_post_action 09:33:17 INFO - [mozharness: 2017-06-01 16:33:17.256148Z] Finished read-buildbot-config step (success) 09:33:17 INFO - [mozharness: 2017-06-01 16:33:17.256370Z] Running download-and-extract step. 09:33:17 INFO - Running pre-action listener: _resource_record_pre_action 09:33:17 INFO - Running main action method: download_and_extract 09:33:17 INFO - mkdir: /builds/slave/test/build/tests 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - trying https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.test_packages.json 09:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:33:17 INFO - Downloaded 986 bytes. 09:33:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:33:17 INFO - Using the following test package requirements: 09:33:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:33:17 INFO - u'common': [u'target.common.tests.zip'], 09:33:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:33:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:33:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:33:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:33:17 INFO - u'mozbase': [u'target.common.tests.zip'], 09:33:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:33:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:33:17 INFO - u'web-platform': [u'target.common.tests.zip', 09:33:17 INFO - u'target.web-platform.tests.zip'], 09:33:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:33:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip 09:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip into memory 09:33:19 INFO - Content-Length response header: 63543412 09:33:19 INFO - Bytes received: 63543412 09:33:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip 09:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:30 INFO - Fetch https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.common.tests.zip into memory 09:33:31 INFO - Content-Length response header: 63543412 09:33:31 INFO - Bytes received: 63543412 09:33:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.talos.tests.zip 09:33:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:33:44 INFO - Fetch https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.talos.tests.zip into memory 09:33:45 INFO - Content-Length response header: 14447425 09:33:45 INFO - Bytes received: 14447425 09:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:45 INFO - trying https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 09:33:45 INFO - Downloading https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:33:46 INFO - Downloaded 56040854 bytes. 09:33:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 09:33:46 INFO - mkdir: /builds/slave/test/properties 09:33:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:46 INFO - Contents: 09:33:46 INFO - build_url:https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 09:33:46 INFO - Running post-action listener: _resource_record_post_action 09:33:46 INFO - Running post-action listener: set_extra_try_arguments 09:33:46 INFO - [mozharness: 2017-06-01 16:33:46.853165Z] Finished download-and-extract step (success) 09:33:46 INFO - [mozharness: 2017-06-01 16:33:46.853262Z] Running populate-webroot step. 09:33:46 INFO - Running pre-action listener: _resource_record_pre_action 09:33:46 INFO - Running main action method: populate_webroot 09:33:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:46 INFO - '--tppagecycles', 09:33:46 INFO - '7'], 09:33:46 INFO - 'tests': ['tsvgm']}}, 09:33:46 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['damp', 'tps']}, 09:33:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'tests': ['damp', 'tps']}, 09:33:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['dromaeo_dom']}, 09:33:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:33:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:33:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:33:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore', 09:33:46 INFO - 'tabpaint']}, 09:33:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:33:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:33:46 INFO - 'bloom_basic_ref']}, 09:33:46 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:33:46 INFO - 'talos_options': ['--mitmproxy', 09:33:46 INFO - 'mitmproxy-recording-1.mp', 09:33:46 INFO - '--firstNonBlankPaint'], 09:33:46 INFO - 'tests': ['Quantum_1']}, 09:33:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['tsvgx', 09:33:46 INFO - 'tsvgr_opacity', 09:33:46 INFO - 'tart', 09:33:46 INFO - 'tscrollx', 09:33:46 INFO - 'cart', 09:33:46 INFO - 'tsvg_static']}, 09:33:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:46 INFO - 'tsvgr_opacity', 09:33:46 INFO - 'tart', 09:33:46 INFO - 'tscrollx', 09:33:46 INFO - 'cart', 09:33:46 INFO - 'tsvg_static']}, 09:33:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'talos_options': ['--disable-e10s'], 09:33:46 INFO - 'tests': ['tp5o']}, 09:33:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:33:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'talos_options': ['--disable-e10s', 09:33:46 INFO - '--xperf_path', 09:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:46 INFO - 'tests': ['tp5n']}, 09:33:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:33:46 INFO - 'talos_options': ['--xperf_path', 09:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:46 INFO - 'tests': ['tp5n']}}, 09:33:46 INFO - 'talos.zip': {'path': '', 09:33:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:46 INFO - Running post-action listener: _resource_record_post_action 09:33:46 INFO - [mozharness: 2017-06-01 16:33:46.867626Z] Finished populate-webroot step (success) 09:33:46 INFO - [mozharness: 2017-06-01 16:33:46.867722Z] Running create-virtualenv step. 09:33:46 INFO - Running pre-action listener: _resource_record_pre_action 09:33:46 INFO - Running main action method: create_virtualenv 09:33:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:33:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:33:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:46 INFO - Using real prefix '/usr' 09:33:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:49 INFO - Installing pip.................done. 09:33:49 INFO - Return code: 0 09:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:49 INFO - Reading from file tmpfile_stdout 09:33:49 INFO - Output received: 09:33:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:33:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:33:49 INFO - Cleaning up... 09:33:49 INFO - Return code: 0 09:33:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:50 INFO - Downloading/unpacking psutil>=3.1.1 09:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:51 INFO - Installing collected packages: psutil 09:33:51 INFO - Running setup.py install for psutil 09:33:51 INFO - building 'psutil._psutil_linux' extension 09:33:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:33:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:33:51 INFO - building 'psutil._psutil_posix' extension 09:33:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:33:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:51 INFO - Successfully installed psutil 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:33:51 INFO - Using env: {'DISPLAY': ':0', 09:33:51 INFO - 'HOME': '/home/cltbld', 09:33:51 INFO - 'LANG': 'en_US.UTF-8', 09:33:51 INFO - 'LANGUAGE': 'en_US:en', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MAIL': '/var/mail/cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SHLVL': '1', 09:33:51 INFO - 'TERM': 'linux', 09:33:51 INFO - 'TMOUT': '86400', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - '_': '/tools/buildbot/bin/python'} 09:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:53 INFO - Installing collected packages: mozsystemmonitor 09:33:53 INFO - Running setup.py install for mozsystemmonitor 09:33:53 INFO - Successfully installed mozsystemmonitor 09:33:53 INFO - Cleaning up... 09:33:53 INFO - Return code: 0 09:33:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:33:53 INFO - Using env: {'DISPLAY': ':0', 09:33:53 INFO - 'HOME': '/home/cltbld', 09:33:53 INFO - 'LANG': 'en_US.UTF-8', 09:33:53 INFO - 'LANGUAGE': 'en_US:en', 09:33:53 INFO - 'LOGNAME': 'cltbld', 09:33:53 INFO - 'MAIL': '/var/mail/cltbld', 09:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:53 INFO - 'MOZ_NO_REMOTE': '1', 09:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:53 INFO - 'NO_EM_RESTART': '1', 09:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:53 INFO - 'PWD': '/builds/slave/test', 09:33:53 INFO - 'SHELL': '/bin/bash', 09:33:53 INFO - 'SHLVL': '1', 09:33:53 INFO - 'TERM': 'linux', 09:33:53 INFO - 'TMOUT': '86400', 09:33:53 INFO - 'USER': 'cltbld', 09:33:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:53 INFO - '_': '/tools/buildbot/bin/python'} 09:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:54 INFO - warning: no files found matching '*.txt' 09:33:54 INFO - no previously-included directories found matching 'build' 09:33:54 INFO - no previously-included directories found matching 'dist' 09:33:54 INFO - no previously-included directories found matching '.git*' 09:33:54 INFO - Installing collected packages: jsonschema, functools32 09:33:54 INFO - Running setup.py install for functools32 09:33:54 INFO - warning: no files found matching '*.txt' 09:33:54 INFO - no previously-included directories found matching 'build' 09:33:54 INFO - no previously-included directories found matching 'dist' 09:33:54 INFO - no previously-included directories found matching '.git*' 09:33:54 INFO - Successfully installed jsonschema functools32 09:33:54 INFO - Cleaning up... 09:33:54 INFO - Return code: 0 09:33:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:54 INFO - Using env: {'DISPLAY': ':0', 09:33:54 INFO - 'HOME': '/home/cltbld', 09:33:54 INFO - 'LANG': 'en_US.UTF-8', 09:33:54 INFO - 'LANGUAGE': 'en_US:en', 09:33:54 INFO - 'LOGNAME': 'cltbld', 09:33:54 INFO - 'MAIL': '/var/mail/cltbld', 09:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:54 INFO - 'MOZ_NO_REMOTE': '1', 09:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:54 INFO - 'NO_EM_RESTART': '1', 09:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:54 INFO - 'PWD': '/builds/slave/test', 09:33:54 INFO - 'SHELL': '/bin/bash', 09:33:54 INFO - 'SHLVL': '1', 09:33:54 INFO - 'TERM': 'linux', 09:33:54 INFO - 'TMOUT': '86400', 09:33:54 INFO - 'USER': 'cltbld', 09:33:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:54 INFO - '_': '/tools/buildbot/bin/python'} 09:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:55 INFO - Cleaning up... 09:33:55 INFO - Return code: 0 09:33:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:55 INFO - Using env: {'DISPLAY': ':0', 09:33:55 INFO - 'HOME': '/home/cltbld', 09:33:55 INFO - 'LANG': 'en_US.UTF-8', 09:33:55 INFO - 'LANGUAGE': 'en_US:en', 09:33:55 INFO - 'LOGNAME': 'cltbld', 09:33:55 INFO - 'MAIL': '/var/mail/cltbld', 09:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:55 INFO - 'MOZ_NO_REMOTE': '1', 09:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:55 INFO - 'NO_EM_RESTART': '1', 09:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:55 INFO - 'PWD': '/builds/slave/test', 09:33:55 INFO - 'SHELL': '/bin/bash', 09:33:55 INFO - 'SHLVL': '1', 09:33:55 INFO - 'TERM': 'linux', 09:33:55 INFO - 'TMOUT': '86400', 09:33:55 INFO - 'USER': 'cltbld', 09:33:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:55 INFO - '_': '/tools/buildbot/bin/python'} 09:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:57 INFO - Downloading docopt-0.6.1.tar.gz 09:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:57 INFO - Running setup.py install for blobuploader 09:33:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:57 INFO - Running setup.py install for requests 09:33:57 INFO - Running setup.py install for docopt 09:33:57 INFO - Successfully installed blobuploader requests docopt 09:33:57 INFO - Cleaning up... 09:33:57 INFO - Return code: 0 09:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:57 INFO - Using env: {'DISPLAY': ':0', 09:33:57 INFO - 'HOME': '/home/cltbld', 09:33:57 INFO - 'LANG': 'en_US.UTF-8', 09:33:57 INFO - 'LANGUAGE': 'en_US:en', 09:33:57 INFO - 'LOGNAME': 'cltbld', 09:33:57 INFO - 'MAIL': '/var/mail/cltbld', 09:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:57 INFO - 'MOZ_NO_REMOTE': '1', 09:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:57 INFO - 'NO_EM_RESTART': '1', 09:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:57 INFO - 'PWD': '/builds/slave/test', 09:33:57 INFO - 'SHELL': '/bin/bash', 09:33:57 INFO - 'SHLVL': '1', 09:33:57 INFO - 'TERM': 'linux', 09:33:57 INFO - 'TMOUT': '86400', 09:33:57 INFO - 'USER': 'cltbld', 09:33:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:57 INFO - '_': '/tools/buildbot/bin/python'} 09:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:57 INFO - Running setup.py (path:/tmp/pip-9ASJDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:57 INFO - Running setup.py (path:/tmp/pip-6x2RCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:58 INFO - Running setup.py (path:/tmp/pip-f8lqzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:58 INFO - Running setup.py (path:/tmp/pip-8lleW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:58 INFO - Running setup.py (path:/tmp/pip-v55xFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:58 INFO - Running setup.py (path:/tmp/pip-lk4unb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:58 INFO - Running setup.py (path:/tmp/pip-dQ4t00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:58 INFO - Running setup.py (path:/tmp/pip-6BA04J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:58 INFO - Running setup.py (path:/tmp/pip-Qlt1f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:58 INFO - Running setup.py (path:/tmp/pip-CpHyVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:58 INFO - Running setup.py (path:/tmp/pip-NkfHUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:58 INFO - Running setup.py (path:/tmp/pip-3FcXIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:58 INFO - Running setup.py (path:/tmp/pip-8sZVVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:58 INFO - Running setup.py (path:/tmp/pip-mgChnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:58 INFO - Running setup.py (path:/tmp/pip-k6kHBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:58 INFO - Running setup.py (path:/tmp/pip-Sp8XKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:59 INFO - Running setup.py (path:/tmp/pip-Zz1k9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:59 INFO - Running setup.py install for manifestparser 09:33:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozcrash 09:33:59 INFO - Running setup.py install for mozdebug 09:33:59 INFO - Running setup.py install for mozdevice 09:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozfile 09:33:59 INFO - Running setup.py install for mozhttpd 09:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozinfo 09:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozInstall 09:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozleak 09:34:00 INFO - Running setup.py install for mozlog 09:34:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Running setup.py install for moznetwork 09:34:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Running setup.py install for mozprocess 09:34:00 INFO - Running setup.py install for mozprofile 09:34:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Running setup.py install for mozrunner 09:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Running setup.py install for mozscreenshot 09:34:00 INFO - Running setup.py install for moztest 09:34:00 INFO - Running setup.py install for mozversion 09:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:00 INFO - Cleaning up... 09:34:00 INFO - Return code: 0 09:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:00 INFO - Using env: {'DISPLAY': ':0', 09:34:00 INFO - 'HOME': '/home/cltbld', 09:34:00 INFO - 'LANG': 'en_US.UTF-8', 09:34:00 INFO - 'LANGUAGE': 'en_US:en', 09:34:00 INFO - 'LOGNAME': 'cltbld', 09:34:00 INFO - 'MAIL': '/var/mail/cltbld', 09:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:00 INFO - 'MOZ_NO_REMOTE': '1', 09:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:00 INFO - 'NO_EM_RESTART': '1', 09:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:00 INFO - 'PWD': '/builds/slave/test', 09:34:00 INFO - 'SHELL': '/bin/bash', 09:34:00 INFO - 'SHLVL': '1', 09:34:00 INFO - 'TERM': 'linux', 09:34:00 INFO - 'TMOUT': '86400', 09:34:00 INFO - 'USER': 'cltbld', 09:34:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:00 INFO - '_': '/tools/buildbot/bin/python'} 09:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:01 INFO - Running setup.py (path:/tmp/pip-WMvKFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:01 INFO - Running setup.py (path:/tmp/pip-IkE3qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:01 INFO - Running setup.py (path:/tmp/pip-FK6ZiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:01 INFO - Running setup.py (path:/tmp/pip-P65iN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:01 INFO - Running setup.py (path:/tmp/pip-urLMP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:01 INFO - Running setup.py (path:/tmp/pip-yvWBCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:01 INFO - Running setup.py (path:/tmp/pip-qa6EVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:01 INFO - Running setup.py (path:/tmp/pip-5bl6q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Running setup.py (path:/tmp/pip-GxU5ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Running setup.py (path:/tmp/pip-jw2QMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Running setup.py (path:/tmp/pip-unVl65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Running setup.py (path:/tmp/pip-CrK_aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:01 INFO - Running setup.py (path:/tmp/pip-PWol4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:02 INFO - Running setup.py (path:/tmp/pip-yU5H0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:02 INFO - Running setup.py (path:/tmp/pip-pMUjaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:02 INFO - Running setup.py (path:/tmp/pip-Gljsuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:02 INFO - Running setup.py (path:/tmp/pip-jbnwvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:03 INFO - Downloading blessings-1.6.tar.gz 09:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:03 INFO - Installing collected packages: blessings 09:34:03 INFO - Running setup.py install for blessings 09:34:03 INFO - Successfully installed blessings 09:34:03 INFO - Cleaning up... 09:34:03 INFO - Return code: 0 09:34:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:03 INFO - Reading from file tmpfile_stdout 09:34:03 INFO - Current package versions: 09:34:03 INFO - argparse == 1.2.1 09:34:03 INFO - blessings == 1.6 09:34:03 INFO - blobuploader == 1.2.4 09:34:03 INFO - docopt == 0.6.1 09:34:03 INFO - functools32 == 3.2.3-2 09:34:03 INFO - jsonschema == 2.5.1 09:34:03 INFO - manifestparser == 1.1 09:34:03 INFO - mozInstall == 1.12 09:34:03 INFO - mozcrash == 1.0 09:34:03 INFO - mozdebug == 0.1 09:34:03 INFO - mozdevice == 0.51 09:34:03 INFO - mozfile == 1.2 09:34:03 INFO - mozhttpd == 0.7 09:34:03 INFO - mozinfo == 0.9 09:34:03 INFO - mozleak == 0.1 09:34:03 INFO - mozlog == 3.4 09:34:03 INFO - moznetwork == 0.27 09:34:03 INFO - mozprocess == 0.25 09:34:03 INFO - mozprofile == 0.28 09:34:03 INFO - mozrunner == 6.13 09:34:03 INFO - mozscreenshot == 0.1 09:34:03 INFO - mozsystemmonitor == 0.3 09:34:03 INFO - moztest == 0.8 09:34:03 INFO - mozversion == 1.4 09:34:03 INFO - psutil == 3.1.1 09:34:03 INFO - requests == 1.2.3 09:34:03 INFO - wsgiref == 0.1.2 09:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:03 INFO - Using env: {'DISPLAY': ':0', 09:34:03 INFO - 'HOME': '/home/cltbld', 09:34:03 INFO - 'LANG': 'en_US.UTF-8', 09:34:03 INFO - 'LANGUAGE': 'en_US:en', 09:34:03 INFO - 'LOGNAME': 'cltbld', 09:34:03 INFO - 'MAIL': '/var/mail/cltbld', 09:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:03 INFO - 'MOZ_NO_REMOTE': '1', 09:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:03 INFO - 'NO_EM_RESTART': '1', 09:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:03 INFO - 'PWD': '/builds/slave/test', 09:34:03 INFO - 'SHELL': '/bin/bash', 09:34:03 INFO - 'SHLVL': '1', 09:34:03 INFO - 'TERM': 'linux', 09:34:03 INFO - 'TMOUT': '86400', 09:34:03 INFO - 'USER': 'cltbld', 09:34:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:03 INFO - '_': '/tools/buildbot/bin/python'} 09:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:34:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:34:05 INFO - Installing collected packages: marionette-driver 09:34:05 INFO - Running setup.py install for marionette-driver 09:34:05 INFO - Successfully installed marionette-driver 09:34:05 INFO - Cleaning up... 09:34:05 INFO - Return code: 0 09:34:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1957dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:34:05 INFO - Using env: {'DISPLAY': ':0', 09:34:05 INFO - 'HOME': '/home/cltbld', 09:34:05 INFO - 'LANG': 'en_US.UTF-8', 09:34:05 INFO - 'LANGUAGE': 'en_US:en', 09:34:05 INFO - 'LOGNAME': 'cltbld', 09:34:05 INFO - 'MAIL': '/var/mail/cltbld', 09:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:05 INFO - 'MOZ_NO_REMOTE': '1', 09:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:05 INFO - 'NO_EM_RESTART': '1', 09:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:05 INFO - 'PWD': '/builds/slave/test', 09:34:05 INFO - 'SHELL': '/bin/bash', 09:34:05 INFO - 'SHLVL': '1', 09:34:05 INFO - 'TERM': 'linux', 09:34:05 INFO - 'TMOUT': '86400', 09:34:05 INFO - 'USER': 'cltbld', 09:34:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:05 INFO - '_': '/tools/buildbot/bin/python'} 09:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:34:05 INFO - Cleaning up... 09:34:05 INFO - Return code: 0 09:34:05 INFO - Running post-action listener: _resource_record_post_action 09:34:05 INFO - Running post-action listener: _start_resource_monitoring 09:34:05 INFO - Starting resource monitoring. 09:34:05 INFO - [mozharness: 2017-06-01 16:34:05.644561Z] Finished create-virtualenv step (success) 09:34:05 INFO - [mozharness: 2017-06-01 16:34:05.645072Z] Running install step. 09:34:05 INFO - Running pre-action listener: _resource_record_pre_action 09:34:05 INFO - Running main action method: install 09:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:05 INFO - Reading from file tmpfile_stdout 09:34:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:05 INFO - Reading from file tmpfile_stdout 09:34:05 INFO - Output received: 09:34:05 INFO - Usage: mozinstall [options] installer 09:34:05 INFO - Options: 09:34:05 INFO - -h, --help show this help message and exit 09:34:05 INFO - -d DEST, --destination=DEST 09:34:05 INFO - Directory to install application into. [default: 09:34:05 INFO - "/builds/slave/test"] 09:34:05 INFO - --app=APP Application being installed. [default: firefox] 09:34:05 INFO - mkdir: /builds/slave/test/build/application 09:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:34:22 INFO - Reading from file tmpfile_stdout 09:34:22 INFO - Output received: 09:34:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:22 INFO - Running post-action listener: _resource_record_post_action 09:34:22 INFO - [mozharness: 2017-06-01 16:34:22.003386Z] Finished install step (success) 09:34:22 INFO - [mozharness: 2017-06-01 16:34:22.003663Z] Running setup-mitmproxy step. 09:34:22 INFO - Running pre-action listener: _resource_record_pre_action 09:34:22 INFO - Running main action method: setup_mitmproxy 09:34:22 INFO - Skipping: mitmproxy is not required 09:34:22 INFO - Running post-action listener: _resource_record_post_action 09:34:22 INFO - [mozharness: 2017-06-01 16:34:22.004783Z] Finished setup-mitmproxy step (success) 09:34:22 INFO - [mozharness: 2017-06-01 16:34:22.005000Z] Running run-tests step. 09:34:22 INFO - Running pre-action listener: _resource_record_pre_action 09:34:22 INFO - Running main action method: run_tests 09:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:22 INFO - Python 2.7.3 09:34:22 INFO - Return code: 0 09:34:22 INFO - grabbing minidump binary from tooltool 09:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1955740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1955bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:34:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:34:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:34:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:22 INFO - Return code: 0 09:34:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:22 INFO - ENV: RUST_BACKTRACE is now 1 09:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:34:22 INFO - Using env: {'DISPLAY': ':0', 09:34:22 INFO - 'HOME': '/home/cltbld', 09:34:22 INFO - 'LANG': 'en_US.UTF-8', 09:34:22 INFO - 'LANGUAGE': 'en_US:en', 09:34:22 INFO - 'LOGNAME': 'cltbld', 09:34:22 INFO - 'MAIL': '/var/mail/cltbld', 09:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:22 INFO - 'MOZ_NO_REMOTE': '1', 09:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:22 INFO - 'NO_EM_RESTART': '1', 09:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:22 INFO - 'PWD': '/builds/slave/test', 09:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:22 INFO - 'RUST_BACKTRACE': '1', 09:34:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:34:22 INFO - 'SHELL': '/bin/bash', 09:34:22 INFO - 'SHLVL': '1', 09:34:22 INFO - 'TERM': 'linux', 09:34:22 INFO - 'TMOUT': '86400', 09:34:22 INFO - 'USER': 'cltbld', 09:34:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560', 09:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:22 INFO - '_': '/tools/buildbot/bin/python'} 09:34:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:34:22 INFO - mozversion application_buildid: 20170601155415 09:34:22 INFO - mozversion application_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 09:34:22 INFO - mozversion application_display_name: Nightly 09:34:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:22 INFO - mozversion application_name: Firefox 09:34:22 INFO - mozversion application_remotingname: firefox 09:34:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:34:22 INFO - mozversion application_vendor: Mozilla 09:34:22 INFO - mozversion application_version: 55.0a1 09:34:22 INFO - mozversion platform_buildid: 20170601155415 09:34:22 INFO - mozversion platform_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 09:34:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:34:22 INFO - mozversion platform_version: 55.0a1 09:34:22 INFO - using testdate: 1496334862 09:34:22 INFO - actual date: 1496334862 09:34:22 INFO - starting webserver on 'localhost:54365' 09:34:22 INFO - SUITE-START | Running 2 tests 09:34:22 INFO - TEST-START | dromaeo_css 09:34:22 INFO - operating with platform_type : linux_ 09:34:22 INFO - Initialising browser for dromaeo_css test... 09:34:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54365/getInfo.html -profile /tmp/tmpUHnO8E/profile 09:34:22 INFO - TEST-INFO | started process 4210 (/builds/slave/test/build/application/firefox/firefox http://localhost:54365/getInfo.html) 09:34:57 INFO - TEST-INFO | 4210: killed by SIGTERM 09:34:58 INFO - Browser initialized. 09:34:58 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:58 INFO - TEST-INFO | started process 4441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHnO8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:09 INFO - PID 4441 | RSS: Main: 188751872 09:35:09 INFO - PID 4441 | 09:38:14 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54365/tests/dromaeo/cssquery-ext.html) 09:38:16 INFO - PID 4441 | RSS: Main: 184188928 09:38:16 INFO - PID 4441 | 09:41:18 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-ext.html (next: http://localhost:54365/tests/dromaeo/cssquery-jquery.html) 09:41:19 INFO - PID 4441 | RSS: Main: 187314176 09:41:19 INFO - PID 4441 | 09:44:20 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54365/tests/dromaeo/cssquery-mootools.html) 09:44:21 INFO - PID 4441 | RSS: Main: 186564608 09:44:21 INFO - PID 4441 | 09:47:23 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54365/tests/dromaeo/cssquery-prototype.html) 09:47:24 INFO - PID 4441 | RSS: Main: 190758912 09:47:24 INFO - PID 4441 | 09:50:27 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54365/tests/dromaeo/cssquery-yui.html) 09:50:27 INFO - PID 4441 | RSS: Main: 189227008 09:50:27 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | Cycle 1(1): loaded http://localhost:54365/tests/dromaeo/cssquery-yui.html (next: http://localhost:54365/tests/dromaeo/cssquery-dojo.html) 09:53:29 INFO - PID 4441 | RSS: Main: 186982400 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | __start_tp_report 09:53:29 INFO - PID 4441 | _x_x_mozilla_page_load 09:53:29 INFO - PID 4441 | _x_x_mozilla_page_load_details 09:53:29 INFO - PID 4441 | |i|pagename|runs| 09:53:29 INFO - PID 4441 | |0;dojo.html;2713.2131681812275;2714.5928110783366;2741.3694850184456;2763.1019918526486;2773.5007698614268;5127.512886275807;5191.636585439021;5243.9737801310985;5250.816221432251;5277.70972596507;5125.461826508219;5187.066328060948;5195.012947539964;5209.400918894328;5315.813946511873;4465.772945834094;4599.724016559009;4618.49196588375;4636.072785442908;4651.4418269807675;4693.0848484545695;4702.412198475191;4752.334673145762;4752.833650822222;4777.665563410563;4554.840580579664;4618.607418369409;4666.719996800169;4668.043051174535;4718.764061796896;4653.511381304982;4685.273782563708;4706.458757242926;4739.14695354836;4763.3569468121705;4544.386507821435;4632.2588385858435;4657.4876763555985;4667.719936803803;4695.694779839299;5090.287359769635;5186.325777648919;5252;5261.605379596545;5304.045271851065;5622.859428514279;5643.097104463307;5688.260526131618;5707.4577915098;5711.371749107595;5663.207150998864;5663.773449062032;5668.093105103164;5670;5678.26182596264;5226.895462090737;5254.7635356409055;5268.552173065333;5275.5515781158265;5284.947150528523;5743.138529220567;5805.622634528827;5813.12803079533;5813.476787089182;5820.35976042635;5452.26394436746;5504.4770746778995;5520.033994051025;5520.1443776214755;5547.944520554824;5552.805651802168;5702.401247868997;5712.65724056558;5717.485426311652;5735.168400581976;5602.915956260659;5614;5623.943760562423;5628.746706398222;5628.802991895264;5365.248865158881;5438.809641662602;5634.6337488063145;5640.717964101778;5640.830775076754;4585.426821647294;4624.1676498230645;4628.861134165913;4650.325702773079;4657.184992626277;4026.939595906064;4028.194361127786;4028.9798551007057;4100.282450571198;4133.731307465006;4760.595349395271;4803.375561177025;4810.470848206694;4814.374131362971;4844.346013288232;5476.205950137288;5588.469095435927;5642.4075472075665;5645.294338207724;5731.025725626653;4791.137595232892;4791.904161916742;4799.160146974265;4828.155072862235;4836.226203807444;4998.325226094431;5031.195008798648;5034.395872495251;5038.168702164102;5042.218456139304;5167.044096842096;5170.97414512925;5225.764840582259;5231.973840130775;5333.973330133324;5675.687837168995;5696.686682232517;5700.372958974426;5746.9712651436475;5761.366249712612;5234.162533994542;5259.237410575522;5275.419703832498;5277.709725965109;5282.9471705283995;5437.048516509674;5463.644863083887;5547.8890422192135;5618.606697531133;5621.100623900156;5637.154426836008;5717.828465146053;5729.942700572941;5763.971180144073;5780.988327042666;5342.332208473941;5526.198701188386;5555.833325000256;5556.638818476786;5564.805231816867;5377.516023557899;5408.945910540844;5433.673979561239;5446.346438427414;5468.91796623059;5400.83797486076;5412.431694672003;5433.483819037185;5437.429069947757;5441.5374693151525;5459.836204913859;5527.115661494142;5532.972335138298;5565.220869078251;5605.32736071674;5358.142697168434;5369.785208591768;5391.460853914734;5403.405625381283;5403.86490337729 09:53:29 INFO - PID 4441 | |1;ext.html;679.5888487465083;717.7595505505656;743.0229248538174;1097.5335482419976;1113.4766659669951;33185.502217466754;34273;34440.311193776106;34485.65514344856;34498.827505862435;36601;37083;37137.257254854885;37159.81420092896;37160.628393716055;6702.497312701543;6915.861682766342;7001.334873187052;7126.928730712679;7153.928460715379;6859.9314006859795;6931.133608298963;6974.965125174367;6977.720891164347;6980.476464265201;6922.342377474157;6952.409045231161;6987.1266091738535;6992.160940687125;6996.195437524673;6888.896666550006;6905.343992320722;6924.861502769942;6925.37671609555;6952.443804495628;6768.221654509745;6768.323167683241;6803.65981700913;6829.93170068298;6842.794716158523;33153.83423082869;33204.00387988364;33387;33547.83226083854;33706.32587348264;3068.6777888321626;3127.937441251185;3131.3580715953176;3140.2149462634343;3144.2296637323775;24613.66170213827;24773.380665483328;24778.132765353308;24871.378215544577;24875.751242487524;2528.5954247320524;2558.373198566363;2558.833675811085;2567.6020216866414;2589.8446093234465;127831;128135;135295.999999999;146564;147809;40556;40761;40800.79599601983;40927;40935.7953210232;42196;42555.148897022504;42561.78719106385;42584.78707606504;42655.78672106682;13098.672533186747;13139.802902956464;13188.47246110164;13221.801672974912;13223;10635.0960168385;10675.199360048027;10683.519241634145;10693;10711.196660250356;12845.61463156088;12941.935290323489;12993.740125197632;13031.218126912416;13171.2755798432;5307.124324486494;5398.541124004425;5481.698506582096;5503;5540.501354878;839.6263662670053;873.7422460374078;876.2070326354659;893.9865902011475;928.8420968435382;21511.816850073083;21516;21655.78344216569;21769.455763606038;21822;974.7806743482802;985.5269470654126;999.6101520407047;1002.834532302162;1005.9295849290479;10977.39624320654;11244.212905096729;11468.541258349573;11486.368249746343;11552.537898484135;174742;175364;176001;176543;176547;42961.35557966633;43095.569044309785;43183.78408107939;43225;43255.78372108119;1176.9229645998262;1228.2753175626424;1234.2902830872285;1235.0490122605722;1236.8701286364983;19878.60242795165;20596.794032060086;21751.347459576238;24522.87738561296;24891.51084891569;37812.08442902515;37915;37969.24061518809;38002.80998594989;38197.23605527818;141791.29104354413;142042;142323;142352;142512;28085.157445276673;30450.390992180477;30458.23854403569;30458.543121853632;30634.84682576573;36499.63500364962;36978.6302136986;37548.616735155636;37864.24271514499;38360.61639383682;28503.28741781472;28737.85631071831;29088.56367154452;29280;30143.38279406485;27584.862075689492;27911.441771164868;28097.71902280951;28584;29212.853935730185;30332;30781.69218307788;31212.375752485277;31252.687473125887;31329.770480984775;27238;27564;27594.5860812092;27746.306342341602;28580.285492862015;20287.391378258675;22332.77667223307;22450;22742.658860116782;22825.543489129792 09:53:29 INFO - PID 4441 | |2;jquery.html;388.19255947628955;395.30821063139507;401.2777001397484;408.5628377635929;414.1323926374245;13564.253966031863;14048.227347495884;18251.361202357904;18877.905610471946;18910.90544547277;18743.90628046858;19539.511512212168;19552.413427597196;19561;19576.412707618758;5417.26866872973;5579.023670857604;5579.553635709133;5583.916241256385;5586.385497595261;5479.397266300703;5551.306086739158;5564.888702225953;5578.0517312056845;5578.665280083188;5510.862228444281;5531.032069387861;5549.472800083986;5557.305336832896;5562;5291;5410.161424979135;5440.891182176374;5447.373552041487;5451.727413629343;4857.587105096071;4858.489858564871;4860.3195552622665;4861.927071093936;4887.780049897763;22370.77629223703;22627.773722262733;22734.545309093726;22737.88631056834;22778.772212277996;1619.5465269724496;1653.5700717813336;1656.097426902329;1656.1967445788782;1658.9751153732705;14838.925805371013;15028.248587570688;15440.073595584301;15514.922425387913;15549.922250388676;1989.9851075951224;2010.2662528177257;2015.133492598182;2023.5851650411778;2105.884176370299;111104.4444777779;112934.43532782365;113854;113932;114268.42865785617;9621;10495.317804342845;10547.84178237327;10835.945820271007;10969.945150274198;14761.114333140045;14771.926140369229;14809.777853332209;14822.407103715947;14848.5545433635;7552.207018263113;7677.424193185533;7724.382049436032;7910.9604451977375;7939.20607939213;7352.926470735331;7383.889241661379;7428.62856857155;7448.180700122982;7536.962315188389;7038.225795162528;7103.254158313406;7139.416750666674;7207.486427850105;7306.123265208103;1900.667383207933;1922;1968.9901550492157;2047.078814533466;2144.5925274197853;828.1304630138451;868.4745728833965;884.8849649545518;900.3427497926419;900.8783814185132;17324.653506930044;17442.56393590145;17645.205965731573;17889.28442862297;18122.637547249244;870.4255191573658;884.3279107878059;890.5591732092655;904.4799240436776;913.5614904845711;9410.670626528039;9431.622735090657;9600.471974041355;9622.807543849083;9626.95186524063;373269;380586;380833;381903;382259;88900;89943.55028224816;90309.54845225732;90878.09121908696;91101.54449227844;1020.5152552537634;1036.0985942230157;1064.7284942339809;1067.594314160614;1067.8718553773442;14916.62708432298;15054;15371.769423458882;15612.141332226382;15964.68070638604;42578;43029.56970430381;43452.782736087385;43902.34146487741;45077.32384014308;52258.73870630775;52382;52401.7379913098;52714;52730.472695272554;9257.166854982814;9376.156145946898;9445.622175112918;9521.523923803921;9525.618975240914;11431.199816012799;12042.518299268282;16033.67932641364;16057.357705691642;16124.516264512084;12117.939410302892;12769;12932.353382331034;12938.741225175256;12941.870581294443;12286.815697764361;12583.748325033264;12625.431855566338;12746.808797868225;12787.680307992374;12755.93622031884;12853.036022298553;12994.870051299366;13002.154859934075;13467;9368.765780855532;9427.434353938786;9434.198093162158;9441.905580944103;9455.385399948982;13278.53525126616;13365.866341336463;13453.798193026916;13466.192028478323;13502.594922152352 09:53:29 INFO - PID 4441 | |3;mootools.html;1261.665658600471;1320.9537666181686;1329.5213723059703;1331.8202042724242;1334.3328335832084;9249.167574918256;9673.371230869989;9685.079917407853;10023.148032417235;10232.283740138193;10024.198064154869;10200.081992620662;10223.795524089532;10257.948710256456;10266.435346055963;2038.7859274776158;2087.6137914485794;2088.6553718636405;2089.039042040663;2091.205341970057;1993.7208790769305;2034.104993802722;2039.5818857134252;2044.3458093410115;2054.2296638760463;1995.9201631934704;2017.959640807183;2028.2900984655325;2030.9492262693477;2037.480442487171;1957.8433725302013;1963.8330741886957;1976.1403789351607;1976.9110390032483;1983.0283161251027;1762.4536393717988;1817.4002579148848;1896.706010568364;1910.7898131205557;1936.6126774644986;9752.658656947044;9992.850107248398;10005.549750261256;10025.59897604095;10037.79924401508;5226.686398816083;5468.453154684539;5472.753726082336;5483.287172667568;5486.3690675572425;3191.888283910052;3219.5492631031675;3294.7364210863075;3315.237495376077;3322.9501557476415;964.3731574476576;967.4340510801189;983.9754006149903;992.4888682328607;993.1657407777501;14483.058601190889;14649.340779665048;14657.780133298009;14665.48670796517;14690;4635.288356311528;4670.6497012724185;4699.953000469952;4840.056189043174;4848.490908454562;11123.55505779776;11134;11204.159688023268;11276.210665253517;11427.885721142848;5294.311739473844;5400.081986062379;5419.674819510842;5422.511973922287;5423.620346575781;4870.878228044327;4961.4046314441775;4963.677360971526;4979.950200498021;4983.277424773388;3854.5374555053572;3876.6898648108086;3943.723939324277;3971.324874771296;3987.601239876047;1162.424914241208;1171.226990186473;1172.818213176959;1190.220405634311;1190.9344986025678;702.796189105164;722.5772922840198;725.5066554742825;726.12501935168;741.9109706835214;5433.510984011458;5520.723963801875;5553.667119891197;5571.804986825523;5649.491545760901;504.8485454363676;525.6583220906441;528.582419888284;530.125293266114;532.5659587436227;3847.1728578355787;3849.5188101487315;3908.296506628777;3920.196359746245;3965.365541513344;12702.491900323883;13032.80450793239;13057.542985995444;13092.214467131813;13143.14569552976;12509.937450312691;12800.487980480862;13076.803847942288;13092.083554151119;13117.0818042738;7143.464240182007;7346.375558077516;7385.6307184640555;7403.148637906602;7405.888911666221;5966.016991504248;6123.418275263843;6124.38756124384;6190.164327815867;6411.134496843053;11504.367259800456;11675.649730508097;11816.291022538675;11856.11079169083;12001.699957501132;11164.218504704593;11237.49431275611;11284.943575282072;11333.716657083638;11390.145739069769;8350.916490835014;8434;8591.957040214758;8626.5255410953;8711.346649001476;9054.094590540893;9316.906830931604;9333.300002499704;9344.34589578723;9346.859797103185;7809.101953275446;7830.33442157423;7838.608069596383;7891.84216315682;8010.279074883056;7857.096433909945;7956.721514746956;7965.163657816078;8039.718609848627;8063.314618257514;6991;7163.820904477429;7208.207097219197;7212.4590655699985;7226.74706385274;4925.507449255046;4938.950610493849;4939.5554400104165;4946.109700253989;5035.84892453227;4995.200767877122;5032.496750324938;5113.7698803553185;5152.793888244429;5152.922706159336 09:53:29 INFO - PID 4441 | |4;prototype.html;326.21545183832876;349.1271820448878;352.6315000824139;353.55981802655697;356.4777600814804;5443.156310771837;5593.244911936888;5603.943960560393;5634.408387119355;5635.464630860072;5399.19012148178;5445.945540544593;5464.207689884975;5469.425710300421;5494.230807686927;4139.0753299715625;4143.7513749175;4150.9584904151025;4152.460180176573;4176.081262122329;4120.711550191488;4143.482064741907;4156.750594964312;4164.562720914306;4166.854160104397;4107.260693075245;4121.855735049274;4125.587441255881;4131.9876630225635;4139.958600413987;4097.8770636880945;4106.0761328700955;4113.938290925638;4126.360414135814;4134.441850350195;3594.946075808865;3598.982005089958;3605.8557657693923;3617.077645200457;3625.655562721537;5425.484578964992;5451.936872309901;5455.918161227585;5460.126379779216;5494.36814766299;4831.637627177941;4841.370621819176;4841.636877234187;4854.2961270615915;4865.537773911473;5757.395473475309;5783.190353350492;5792.362840087587;5798.565107616945;5800.419958004208;4041.4341992121126;4045.251628448717;4046.919061618751;4075.9388609170887;4090.6522945549664;5929.258842644669;6114.357992410777;6169.969150154266;6206.665566903138;6250.811955989498;4059.573744756817;4113.773742444194;4142.502899652061;4145.0880806222585;4154.5222299435345;4194.706370554032;4205.558416366299;4209.894752631209;4213.557576454428;4225.598568136023;4696.577308042292;4814.542618451242;4824.541668541483;4855.247436647325;4861.246506791453;5833.724847309552;5843.883122337529;5845.473907348274;5864.882702345929;5875.294964604275;1430.29915341484;1435.1604311477693;1440.517426662059;1440.5246268731294;1442.3293168676405;936.2556767369957;959.6257459590765;973.090160699748;974.3423189347304;979.779549601334;5010.549050585465;5063.316442285594;5075.441701412841;5079.74601269935;5091.163394774979;6028.57799953999;6054.212952316171;6075.724097939394;6077.179580756541;6086.786962456293;5036.219385995177;5062.658395525189;5065.924011139836;5072.315237442972;5074.746262686851;3201.583794106751;3228.499582564706;3234.5956755405573;3239.174010627275;3244.286257023451;5619.690916999522;5633.605647604629;5634.211210430543;5645.717714114277;5648.096304591246;6167.444929956326;6177.166082578884;6182.196314479089;6214.40963108504;6228.968855155696;5583.190437386637;5603.635763675348;5607.7476513556985;5618;5626.465485778845;6008.969955150196;6024.759009639565;6025.87948241024;6039.698015099315;6054.9091763624465;5903.2325797647745;5904.704764761659;5928.614640048383;5936.347001829881;5959.344472108151;5260.631755777212;5554.50009499147;5612.130119831432;5615.606907516435;5624.156376543551;4061.070991279119;4099.077707515785;4112.074783173762;4112.09533902541;4118.279301122232;6056.6076399822705;6057.002378430215;6057.151998720271;6065.423784740443;6072.90890636632;5673.8297851064535;5827.125931110368;5859.589828711949;5885.352611212848;5894.616849904743;5867.589268751147;5873.70778428745;5888.735006924784;5890;5893.351731309467;5747.3103227612955;5752.453516915886;5757.905997860393;5760.6255593386295;5766.94233057664;5871.236739223874;5876.882462350814;5896.64620122794;5926.259217597801;5927.970360148344;5661.518770904519;5674.858128546819;5677.858053548694;5734.254546908875;5735.225744524436 09:53:29 INFO - PID 4441 | |5;yui.html;722.501473982952;737.9631018449077;746.6117618838205;756.6027835386421;762.7635433015764;13381.7992730109;14027.719445611081;14134.081284716487;16575.751363729552;18229.36197233097;15090.47183348583;15152.469663561778;15254.161021143833;15283.312250948706;15381.538553843402;893.2273583350404;911.5168960450939;911.7538264668535;914.8581969794659;915.1534830281996;901.184428092574;904.1094521895927;924.1590152960807;930.9069093090704;934.3693007220133;966.3332300712486;968.1286841842327;969.5249327829348;969.9127078562927;970.0929630795229;945.716285114463;949.9667511637094;950.4439902656954;956.5217391304348;956.8038552096838;704.9541779784349;706.0679902528664;708.1643660480631;709.0888208651909;710.7086094701148;13899.305034748222;13899.652508687263;14020.158790472604;14063;14096.718065638732;15084.924575377163;15312;15379.692406151926;15401.460948866736;15408.075515468996;12296.631101066982;12467.688307792378;12618.873811261861;12625.242485450903;12741.490340386466;2993.760499160084;3011.533212352067;3019.2753739102677;3024.6370435547656;3025.5461680747844;86600.56699716461;88080;89300;89734.5513272436;90266;11494.310341379543;12272.754544909052;12442.937785311016;12450.377481125908;12675.429605667767;19453.805461945198;19748.50628734293;19756.407307780788;19761.703574446394;19810.306639267557;6028.2766068072115;6088.512918966472;6191.721372538246;6226.5641405101205;6252.843678908063;2778.19432364612;2902.2309088091674;2917.9854100729362;2981.4782413077623;2983.2690990707415;3793.255102652811;3843.3466310727244;3899.2201559688174;3900.258950799339;3902.434147048662;730.0071902212986;744.181400459501;759.8670232709254;764.1365257259262;766.5400759544228;558.6592178770946;582.0774073094193;589.3340525206575;598.4344794169555;607.6323824086364;9477.720507731507;9762.609495620238;10029.498525073863;10292.228082893813;10776.78446431067;564.94350564944;566.2242727463401;572.2703552969997;588.0561698473973;599.2090440618429;4215.683823713172;4386.583274588909;4395.626371758436;4414.514403415622;4515.774211289422;77747.61126194333;80058;82716;89963.55018224867;91313;64730.67634661797;65006.34993650003;65102.674486627264;65192.67403662951;66582.99999999903;56855.715721421126;59689.701551492835;59700;60512;61803.38196618066;10152;10419.53112109972;11119.555217791521;11370.602028928948;11485.483153257956;26581.734182657925;26750.866245668647;27180.864095679393;28401.147965561067;28444.431111377242;50096;50444.49555504398;50489.74755126201;51837.48162518327;52065.7396713014;13022.739545208853;13092.083554151499;13246.867531324564;13418.93290533541;13558.93220533891;15774.526764197093;16198.757018644494;16464;16777.412790552273;17493.775435719886;13005.154664946747;13514.79727804064;13725;15362;15662.843371566138;14914.627134321729;14944.925275373553;15503;15709.135997519788;15765.763513547077;13919.512817051354;13960.673735995064;15308.61728456753;15312.693746125238;15390.307436165176;9803.803923921625;9842.655507057505;10165.695029149138;10230.232732545237;10522.526486308288;11093.389863557582;11368.134834156426;11598.362090085126;11917.463714132711;12017.879821201675 09:53:29 INFO - PID 4441 | __end_tp_report 09:53:29 INFO - PID 4441 | __start_cc_report 09:53:29 INFO - PID 4441 | _x_x_mozilla_cycle_collect,412 09:53:29 INFO - PID 4441 | __end_cc_report 09:53:29 INFO - PID 4441 | __startTimestamp1496336009852__endTimestamp 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | ------- Summary: start ------- 09:53:29 INFO - PID 4441 | Number of tests: 6 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#0] dojo.html Cycles:165 Average:5157.01 Median:5304.05 stddev:606.91 (11.4%) stddev-sans-first:577.70 09:53:29 INFO - PID 4441 | Values: 2713.2 2714.6 2741.4 2763.1 2773.5 5127.5 5191.6 5244.0 5250.8 5277.7 5125.5 5187.1 5195.0 5209.4 5315.8 4465.8 4599.7 4618.5 4636.1 4651.4 4693.1 4702.4 4752.3 4752.8 4777.7 4554.8 4618.6 4666.7 4668.0 4718.8 4653.5 4685.3 4706.5 4739.1 4763.4 4544.4 4632.3 4657.5 4667.7 4695.7 5090.3 5186.3 5252.0 5261.6 5304.0 5622.9 5643.1 5688.3 5707.5 5711.4 5663.2 5663.8 5668.1 5670.0 5678.3 5226.9 5254.8 5268.6 5275.6 5284.9 5743.1 5805.6 5813.1 5813.5 5820.4 5452.3 5504.5 5520.0 5520.1 5547.9 5552.8 5702.4 5712.7 5717.5 5735.2 5602.9 5614.0 5623.9 5628.7 5628.8 5365.2 5438.8 5634.6 5640.7 5640.8 4585.4 4624.2 4628.9 4650.3 4657.2 4026.9 4028.2 4029.0 4100.3 4133.7 4760.6 4803.4 4810.5 4814.4 4844.3 5476.2 5588.5 5642.4 5645.3 5731.0 4791.1 4791.9 4799.2 4828.2 4836.2 4998.3 5031.2 5034.4 5038.2 5042.2 5167.0 5171.0 5225.8 5232.0 5334.0 5675.7 5696.7 5700.4 5747.0 5761.4 5234.2 5259.2 5275.4 5277.7 5282.9 5437.0 5463.6 5547.9 5618.6 5621.1 5637.2 5717.8 5729.9 5764.0 5781.0 5342.3 5526.2 5555.8 5556.6 5564.8 5377.5 5408.9 5433.7 5446.3 5468.9 5400.8 5412.4 5433.5 5437.4 5441.5 5459.8 5527.1 5533.0 5565.2 5605.3 5358.1 5369.8 5391.5 5403.4 5403.9 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#1] ext.html Cycles:180 Average:30462.04 Median:16925.18 stddev:39438.00 (233.0%) stddev-sans-first:39485.23 09:53:29 INFO - PID 4441 | Values: 679.6 717.8 743.0 1097.5 1113.5 33185.5 34273.0 34440.3 34485.7 34498.8 36601.0 37083.0 37137.3 37159.8 37160.6 6702.5 6915.9 7001.3 7126.9 7153.9 6859.9 6931.1 6975.0 6977.7 6980.5 6922.3 6952.4 6987.1 6992.2 6996.2 6888.9 6905.3 6924.9 6925.4 6952.4 6768.2 6768.3 6803.7 6829.9 6842.8 33153.8 33204.0 33387.0 33547.8 33706.3 3068.7 3127.9 3131.4 3140.2 3144.2 24613.7 24773.4 24778.1 24871.4 24875.8 2528.6 2558.4 2558.8 2567.6 2589.8 127831.0 128135.0 135296.0 146564.0 147809.0 40556.0 40761.0 40800.8 40927.0 40935.8 42196.0 42555.1 42561.8 42584.8 42655.8 13098.7 13139.8 13188.5 13221.8 13223.0 10635.1 10675.2 10683.5 10693.0 10711.2 12845.6 12941.9 12993.7 13031.2 13171.3 5307.1 5398.5 5481.7 5503.0 5540.5 839.6 873.7 876.2 894.0 928.8 21511.8 21516.0 21655.8 21769.5 21822.0 974.8 985.5 999.6 1002.8 1005.9 10977.4 11244.2 11468.5 11486.4 11552.5 174742.0 175364.0 176001.0 176543.0 176547.0 42961.4 43095.6 43183.8 43225.0 43255.8 1176.9 1228.3 1234.3 1235.0 1236.9 19878.6 20596.8 21751.3 24522.9 24891.5 37812.1 37915.0 37969.2 38002.8 38197.2 141791.3 142042.0 142323.0 142352.0 142512.0 28085.2 30450.4 30458.2 30458.5 30634.8 36499.6 36978.6 37548.6 37864.2 38360.6 28503.3 28737.9 29088.6 29280.0 30143.4 27584.9 27911.4 28097.7 28584.0 29212.9 30332.0 30781.7 31212.4 31252.7 31329.8 27238.0 27564.0 27594.6 27746.3 28580.3 20287.4 22332.8 22450.0 22742.7 22825.5 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#2] jquery.html Cycles:180 Average:26788.85 Median:380709.50 stddev:64249.72 (16.9%) stddev-sans-first:64399.38 09:53:29 INFO - PID 4441 | Values: 388.2 395.3 401.3 408.6 414.1 13564.3 14048.2 18251.4 18877.9 18910.9 18743.9 19539.5 19552.4 19561.0 19576.4 5417.3 5579.0 5579.6 5583.9 5586.4 5479.4 5551.3 5564.9 5578.1 5578.7 5510.9 5531.0 5549.5 5557.3 5562.0 5291.0 5410.2 5440.9 5447.4 5451.7 4857.6 4858.5 4860.3 4861.9 4887.8 22370.8 22627.8 22734.5 22737.9 22778.8 1619.5 1653.6 1656.1 1656.2 1659.0 14838.9 15028.2 15440.1 15514.9 15549.9 1990.0 2010.3 2015.1 2023.6 2105.9 111104.4 112934.4 113854.0 113932.0 114268.4 9621.0 10495.3 10547.8 10835.9 10969.9 14761.1 14771.9 14809.8 14822.4 14848.6 7552.2 7677.4 7724.4 7911.0 7939.2 7352.9 7383.9 7428.6 7448.2 7537.0 7038.2 7103.3 7139.4 7207.5 7306.1 1900.7 1922.0 1969.0 2047.1 2144.6 828.1 868.5 884.9 900.3 900.9 17324.7 17442.6 17645.2 17889.3 18122.6 870.4 884.3 890.6 904.5 913.6 9410.7 9431.6 9600.5 9622.8 9627.0 373269.0 380586.0 380833.0 381903.0 382259.0 88900.0 89943.6 90309.5 90878.1 91101.5 1020.5 1036.1 1064.7 1067.6 1067.9 14916.6 15054.0 15371.8 15612.1 15964.7 42578.0 43029.6 43452.8 43902.3 45077.3 52258.7 52382.0 52401.7 52714.0 52730.5 9257.2 9376.2 9445.6 9521.5 9525.6 11431.2 12042.5 16033.7 16057.4 16124.5 12117.9 12769.0 12932.4 12938.7 12941.9 12286.8 12583.7 12625.4 12746.8 12787.7 12755.9 12853.0 12994.9 13002.2 13467.0 9368.8 9427.4 9434.2 9441.9 9455.4 13278.5 13365.9 13453.8 13466.2 13502.6 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#3] mootools.html Cycles:180 Average:6138.72 Median:4652.97 stddev:3973.39 (85.4%) stddev-sans-first:3967.64 09:53:29 INFO - PID 4441 | Values: 1261.7 1321.0 1329.5 1331.8 1334.3 9249.2 9673.4 9685.1 10023.1 10232.3 10024.2 10200.1 10223.8 10257.9 10266.4 2038.8 2087.6 2088.7 2089.0 2091.2 1993.7 2034.1 2039.6 2044.3 2054.2 1995.9 2018.0 2028.3 2030.9 2037.5 1957.8 1963.8 1976.1 1976.9 1983.0 1762.5 1817.4 1896.7 1910.8 1936.6 9752.7 9992.9 10005.5 10025.6 10037.8 5226.7 5468.5 5472.8 5483.3 5486.4 3191.9 3219.5 3294.7 3315.2 3323.0 964.4 967.4 984.0 992.5 993.2 14483.1 14649.3 14657.8 14665.5 14690.0 4635.3 4670.6 4700.0 4840.1 4848.5 11123.6 11134.0 11204.2 11276.2 11427.9 5294.3 5400.1 5419.7 5422.5 5423.6 4870.9 4961.4 4963.7 4980.0 4983.3 3854.5 3876.7 3943.7 3971.3 3987.6 1162.4 1171.2 1172.8 1190.2 1190.9 702.8 722.6 725.5 726.1 741.9 5433.5 5520.7 5553.7 5571.8 5649.5 504.8 525.7 528.6 530.1 532.6 3847.2 3849.5 3908.3 3920.2 3965.4 12702.5 13032.8 13057.5 13092.2 13143.1 12509.9 12800.5 13076.8 13092.1 13117.1 7143.5 7346.4 7385.6 7403.1 7405.9 5966.0 6123.4 6124.4 6190.2 6411.1 11504.4 11675.6 11816.3 11856.1 12001.7 11164.2 11237.5 11284.9 11333.7 11390.1 8350.9 8434.0 8592.0 8626.5 8711.3 9054.1 9316.9 9333.3 9344.3 9346.9 7809.1 7830.3 7838.6 7891.8 8010.3 7857.1 7956.7 7965.2 8039.7 8063.3 6991.0 7163.8 7208.2 7212.5 7226.7 4925.5 4939.0 4939.6 4946.1 5035.8 4995.2 5032.5 5113.8 5152.8 5152.9 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#4] prototype.html Cycles:180 Average:4799.90 Median:5494.30 stddev:1436.08 (26.1%) stddev-sans-first:1400.30 09:53:29 INFO - PID 4441 | Values: 326.2 349.1 352.6 353.6 356.5 5443.2 5593.2 5603.9 5634.4 5635.5 5399.2 5445.9 5464.2 5469.4 5494.2 4139.1 4143.8 4151.0 4152.5 4176.1 4120.7 4143.5 4156.8 4164.6 4166.9 4107.3 4121.9 4125.6 4132.0 4140.0 4097.9 4106.1 4113.9 4126.4 4134.4 3594.9 3599.0 3605.9 3617.1 3625.7 5425.5 5451.9 5455.9 5460.1 5494.4 4831.6 4841.4 4841.6 4854.3 4865.5 5757.4 5783.2 5792.4 5798.6 5800.4 4041.4 4045.3 4046.9 4075.9 4090.7 5929.3 6114.4 6170.0 6206.7 6250.8 4059.6 4113.8 4142.5 4145.1 4154.5 4194.7 4205.6 4209.9 4213.6 4225.6 4696.6 4814.5 4824.5 4855.2 4861.2 5833.7 5843.9 5845.5 5864.9 5875.3 1430.3 1435.2 1440.5 1440.5 1442.3 936.3 959.6 973.1 974.3 979.8 5010.5 5063.3 5075.4 5079.7 5091.2 6028.6 6054.2 6075.7 6077.2 6086.8 5036.2 5062.7 5065.9 5072.3 5074.7 3201.6 3228.5 3234.6 3239.2 3244.3 5619.7 5633.6 5634.2 5645.7 5648.1 6167.4 6177.2 6182.2 6214.4 6229.0 5583.2 5603.6 5607.7 5618.0 5626.5 6009.0 6024.8 6025.9 6039.7 6054.9 5903.2 5904.7 5928.6 5936.3 5959.3 5260.6 5554.5 5612.1 5615.6 5624.2 4061.1 4099.1 4112.1 4112.1 4118.3 6056.6 6057.0 6057.2 6065.4 6072.9 5673.8 5827.1 5859.6 5885.4 5894.6 5867.6 5873.7 5888.7 5890.0 5893.4 5747.3 5752.5 5757.9 5760.6 5766.9 5871.2 5876.9 5896.6 5926.3 5928.0 5661.5 5674.9 5677.9 5734.3 5735.2 09:53:29 INFO - PID 4441 | 09:53:29 INFO - PID 4441 | [#5] yui.html Cycles:180 Average:17370.71 Median:3409.40 stddev:22805.41 (668.9%) stddev-sans-first:22835.12 09:53:29 INFO - PID 4441 | Values: 722.5 738.0 746.6 756.6 762.8 13381.8 14027.7 14134.1 16575.8 18229.4 15090.5 15152.5 15254.2 15283.3 15381.5 893.2 911.5 911.8 914.9 915.2 901.2 904.1 924.2 930.9 934.4 966.3 968.1 969.5 969.9 970.1 945.7 950.0 950.4 956.5 956.8 705.0 706.1 708.2 709.1 710.7 13899.3 13899.7 14020.2 14063.0 14096.7 15084.9 15312.0 15379.7 15401.5 15408.1 12296.6 12467.7 12618.9 12625.2 12741.5 2993.8 3011.5 3019.3 3024.6 3025.5 86600.6 88080.0 89300.0 89734.6 90266.0 11494.3 12272.8 12442.9 12450.4 12675.4 19453.8 19748.5 19756.4 19761.7 19810.3 6028.3 6088.5 6191.7 6226.6 6252.8 2778.2 2902.2 2918.0 2981.5 2983.3 3793.3 3843.3 3899.2 3900.3 3902.4 730.0 744.2 759.9 764.1 766.5 558.7 582.1 589.3 598.4 607.6 9477.7 9762.6 10029.5 10292.2 10776.8 564.9 566.2 572.3 588.1 599.2 4215.7 4386.6 4395.6 4414.5 4515.8 77747.6 80058.0 82716.0 89963.6 91313.0 64730.7 65006.3 65102.7 65192.7 66583.0 56855.7 59689.7 59700.0 60512.0 61803.4 10152.0 10419.5 11119.6 11370.6 11485.5 26581.7 26750.9 27180.9 28401.1 28444.4 50096.0 50444.5 50489.7 51837.5 52065.7 13022.7 13092.1 13246.9 13418.9 13558.9 15774.5 16198.8 16464.0 16777.4 17493.8 13005.2 13514.8 13725.0 15362.0 15662.8 14914.6 14944.9 15503.0 15709.1 15765.8 13919.5 13960.7 15308.6 15312.7 15390.3 9803.8 9842.7 10165.7 10230.2 10522.5 11093.4 11368.1 11598.4 11917.5 12017.9 09:53:29 INFO - PID 4441 | -------- Summary: end -------- 09:53:29 INFO - PID 4441 | 09:53:30 INFO - TEST-INFO | 4441: exit 0 09:53:30 INFO - TEST-OK | dromaeo_css | took 1148510ms 09:53:30 INFO - TEST-START | kraken 09:53:30 INFO - operating with platform_type : linux_ 09:53:30 INFO - Initialising browser for kraken test... 09:53:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54365/getInfo.html -profile /tmp/tmpH2gbK1/profile 09:53:30 INFO - TEST-INFO | started process 4865 (/builds/slave/test/build/application/firefox/firefox http://localhost:54365/getInfo.html) 09:54:06 INFO - TEST-INFO | 4865: killed by SIGTERM 09:54:06 INFO - Browser initialized. 09:54:06 INFO - Running cycle 1/1 for kraken test... 09:54:06 INFO - TEST-INFO | started process 5096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH2gbK1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:18 INFO - PID 5096 | RSS: Main: 188633088 09:54:18 INFO - PID 5096 | 09:54:21 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54365/tests/kraken/driver.html?testName=audio-beat-detection) 09:54:22 INFO - PID 5096 | RSS: Main: 191553536 09:54:22 INFO - PID 5096 | 09:54:24 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54365/tests/kraken/driver.html?testName=audio-dft) 09:54:25 INFO - PID 5096 | RSS: Main: 190554112 09:54:25 INFO - PID 5096 | 09:54:28 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54365/tests/kraken/driver.html?testName=audio-fft) 09:54:29 INFO - PID 5096 | RSS: Main: 186404864 09:54:29 INFO - PID 5096 | 09:54:31 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54365/tests/kraken/driver.html?testName=audio-oscillator) 09:54:31 INFO - PID 5096 | RSS: Main: 186519552 09:54:31 INFO - PID 5096 | 09:54:33 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:54:34 INFO - PID 5096 | RSS: Main: 186724352 09:54:34 INFO - PID 5096 | 09:54:37 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54365/tests/kraken/driver.html?testName=imaging-darkroom) 09:54:38 INFO - PID 5096 | RSS: Main: 187842560 09:54:38 INFO - PID 5096 | 09:54:41 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54365/tests/kraken/driver.html?testName=imaging-desaturate) 09:54:42 INFO - PID 5096 | RSS: Main: 186806272 09:54:42 INFO - PID 5096 | 09:54:45 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54365/tests/kraken/driver.html?testName=json-parse-financial) 09:54:46 INFO - PID 5096 | RSS: Main: 187531264 09:54:46 INFO - PID 5096 | 09:54:47 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:48 INFO - PID 5096 | RSS: Main: 187482112 09:54:48 INFO - PID 5096 | 09:54:50 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:50 INFO - PID 5096 | RSS: Main: 187207680 09:54:50 INFO - PID 5096 | 09:54:53 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:53 INFO - PID 5096 | RSS: Main: 186716160 09:54:53 INFO - PID 5096 | 09:54:56 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:57 INFO - PID 5096 | RSS: Main: 187252736 09:54:57 INFO - PID 5096 | 09:55:00 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:01 INFO - PID 5096 | RSS: Main: 187240448 09:55:01 INFO - PID 5096 | 09:55:02 INFO - PID 5096 | Cycle 1(1): loaded http://localhost:54365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54365/tests/kraken/driver.html?testName=ai-astar) 09:55:03 INFO - PID 5096 | RSS: Main: 188768256 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | __start_tp_report 09:55:03 INFO - PID 5096 | _x_x_mozilla_page_load 09:55:03 INFO - PID 5096 | _x_x_mozilla_page_load_details 09:55:03 INFO - PID 5096 | |i|pagename|runs| 09:55:03 INFO - PID 5096 | |0;ai-astar;102;111;110;110;109;110;109;108;111;109 09:55:03 INFO - PID 5096 | |1;audio-beat-detection;153;122;123;162;124;123;123;129;156;125 09:55:03 INFO - PID 5096 | |2;audio-dft;168;163;173;167;169;170;168;162;163;163 09:55:03 INFO - PID 5096 | |3;audio-fft;74;73;74;110;74;81;75;75;94;74 09:55:03 INFO - PID 5096 | |4;audio-oscillator;86;84;108;85;88;83;95;83;82;107 09:55:03 INFO - PID 5096 | |5;imaging-gaussian-blur;114;115;114;118;115;118;114;114;115;114 09:55:03 INFO - PID 5096 | |6;imaging-darkroom;150;151;151;150;150;150;149;152;150;150 09:55:03 INFO - PID 5096 | |7;imaging-desaturate;99;103;98;95;94;95;94;95;94;94 09:55:03 INFO - PID 5096 | |8;json-parse-financial;54;60;54;58;56;57;56;57;58;55 09:55:03 INFO - PID 5096 | |9;json-stringify-tinderbox;55;56;57;57;56;55;55;55;56;56 09:55:03 INFO - PID 5096 | |10;stanford-crypto-aes;86;86;88;86;87;86;87;86;126;88 09:55:03 INFO - PID 5096 | |11;stanford-crypto-ccm;138;137;136;135;137;129;131;129;135;134 09:55:03 INFO - PID 5096 | |12;stanford-crypto-pbkdf2;188;201;194;194;196;198;196;197;186;199 09:55:03 INFO - PID 5096 | |13;stanford-crypto-sha256-iterative;76;76;77;72;75;75;72;72;71;72 09:55:03 INFO - PID 5096 | __end_tp_report 09:55:03 INFO - PID 5096 | __start_cc_report 09:55:03 INFO - PID 5096 | _x_x_mozilla_cycle_collect,1032 09:55:03 INFO - PID 5096 | __end_cc_report 09:55:03 INFO - PID 5096 | __startTimestamp1496336103209__endTimestamp 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | ------- Summary: start ------- 09:55:03 INFO - PID 5096 | Number of tests: 14 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.60 (2.4%) stddev-sans-first:1.00 09:55:03 INFO - PID 5096 | Values: 102.0 111.0 110.0 110.0 109.0 110.0 109.0 108.0 111.0 109.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:127.00 stddev:16.13 (12.7%) stddev-sans-first:15.58 09:55:03 INFO - PID 5096 | Values: 153.0 122.0 123.0 162.0 124.0 123.0 123.0 129.0 156.0 125.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#2] audio-dft Cycles:10 Average:166.60 Median:168.00 stddev:3.69 (2.2%) stddev-sans-first:3.88 09:55:03 INFO - PID 5096 | Values: 168.0 163.0 173.0 167.0 169.0 170.0 168.0 162.0 163.0 163.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.50 stddev:12.19 (16.4%) stddev-sans-first:12.71 09:55:03 INFO - PID 5096 | Values: 74.0 73.0 74.0 110.0 74.0 81.0 75.0 75.0 94.0 74.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.50 stddev:9.89 (11.7%) stddev-sans-first:10.38 09:55:03 INFO - PID 5096 | Values: 86.0 84.0 108.0 85.0 88.0 83.0 95.0 83.0 82.0 107.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.60 (1.4%) stddev-sans-first:1.64 09:55:03 INFO - PID 5096 | Values: 114.0 115.0 114.0 118.0 115.0 118.0 114.0 114.0 115.0 114.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:55:03 INFO - PID 5096 | Values: 150.0 151.0 151.0 150.0 150.0 150.0 149.0 152.0 150.0 150.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:3.00 (3.2%) stddev-sans-first:2.99 09:55:03 INFO - PID 5096 | Values: 99.0 103.0 98.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.90 (3.3%) stddev-sans-first:1.79 09:55:03 INFO - PID 5096 | Values: 54.0 60.0 54.0 58.0 56.0 57.0 56.0 57.0 58.0 55.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 09:55:03 INFO - PID 5096 | Values: 55.0 56.0 57.0 57.0 56.0 55.0 55.0 55.0 56.0 56.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:86.50 stddev:12.47 (14.4%) stddev-sans-first:13.11 09:55:03 INFO - PID 5096 | Values: 86.0 86.0 88.0 86.0 87.0 86.0 87.0 86.0 126.0 88.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:135.50 stddev:3.31 (2.4%) stddev-sans-first:3.20 09:55:03 INFO - PID 5096 | Values: 138.0 137.0 136.0 135.0 137.0 129.0 131.0 129.0 135.0 134.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:196.50 stddev:4.70 (2.4%) stddev-sans-first:4.27 09:55:03 INFO - PID 5096 | Values: 188.0 201.0 194.0 194.0 196.0 198.0 196.0 197.0 186.0 199.0 09:55:03 INFO - PID 5096 | 09:55:03 INFO - PID 5096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:75.00 stddev:2.20 (2.9%) stddev-sans-first:2.19 09:55:03 INFO - PID 5096 | Values: 76.0 76.0 77.0 72.0 75.0 75.0 72.0 72.0 71.0 72.0 09:55:03 INFO - PID 5096 | -------- Summary: end -------- 09:55:03 INFO - PID 5096 | 09:55:04 INFO - TEST-INFO | 5096: exit 0 09:55:04 INFO - TEST-OK | kraken | took 93753ms 09:55:04 INFO - SUITE-END | took 1242s 09:55:04 INFO - Completed test suite (00:20:42) 09:55:04 INFO - javascript benchmark 09:55:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6796.129656924065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.2131681812275, 2714.5928110783366, 2741.3694850184456, 2763.1019918526486, 2773.5007698614268, 5127.512886275807, 5191.636585439021, 5243.9737801310985, 5250.816221432251, 5277.70972596507, 5125.461826508219, 5187.066328060948, 5195.012947539964, 5209.400918894328, 5315.813946511873, 4465.772945834094, 4599.724016559009, 4618.49196588375, 4636.072785442908, 4651.4418269807675, 4693.0848484545695, 4702.412198475191, 4752.334673145762, 4752.833650822222, 4777.665563410563, 4554.840580579664, 4618.607418369409, 4666.719996800169, 4668.043051174535, 4718.764061796896, 4653.511381304982, 4685.273782563708, 4706.458757242926, 4739.14695354836, 4763.3569468121705, 4544.386507821435, 4632.2588385858435, 4657.4876763555985, 4667.719936803803, 4695.694779839299, 5090.287359769635, 5186.325777648919, 5252.0, 5261.605379596545, 5304.045271851065, 5622.859428514279, 5643.097104463307, 5688.260526131618, 5707.4577915098, 5711.371749107595, 5663.207150998864, 5663.773449062032, 5668.093105103164, 5670.0, 5678.26182596264, 5226.895462090737, 5254.7635356409055, 5268.552173065333, 5275.5515781158265, 5284.947150528523, 5743.138529220567, 5805.622634528827, 5813.12803079533, 5813.476787089182, 5820.35976042635, 5452.26394436746, 5504.4770746778995, 5520.033994051025, 5520.1443776214755, 5547.944520554824, 5552.805651802168, 5702.401247868997, 5712.65724056558, 5717.485426311652, 5735.168400581976, 5602.915956260659, 5614.0, 5623.943760562423, 5628.746706398222, 5628.802991895264, 5365.248865158881, 5438.809641662602, 5634.6337488063145, 5640.717964101778, 5640.830775076754, 4585.426821647294, 4624.1676498230645, 4628.861134165913, 4650.325702773079, 4657.184992626277, 4026.939595906064, 4028.194361127786, 4028.9798551007057, 4100.282450571198, 4133.731307465006, 4760.595349395271, 4803.375561177025, 4810.470848206694, 4814.374131362971, 4844.346013288232, 5476.205950137288, 5588.469095435927, 5642.4075472075665, 5645.294338207724, 5731.025725626653, 4791.137595232892, 4791.904161916742, 4799.160146974265, 4828.155072862235, 4836.226203807444, 4998.325226094431, 5031.195008798648, 5034.395872495251, 5038.168702164102, 5042.218456139304, 5167.044096842096, 5170.97414512925, 5225.764840582259, 5231.973840130775, 5333.973330133324, 5675.687837168995, 5696.686682232517, 5700.372958974426, 5746.9712651436475, 5761.366249712612, 5234.162533994542, 5259.237410575522, 5275.419703832498, 5277.709725965109, 5282.9471705283995, 5437.048516509674, 5463.644863083887, 5547.8890422192135, 5618.606697531133, 5621.100623900156, 5637.154426836008, 5717.828465146053, 5729.942700572941, 5763.971180144073, 5780.988327042666, 5342.332208473941, 5526.198701188386, 5555.833325000256, 5556.638818476786, 5564.805231816867, 5377.516023557899, 5408.945910540844, 5433.673979561239, 5446.346438427414, 5468.91796623059, 5400.83797486076, 5412.431694672003, 5433.483819037185, 5437.429069947757, 5441.5374693151525, 5459.836204913859, 5527.115661494142, 5532.972335138298, 5565.220869078251, 5605.32736071674, 5358.142697168434, 5369.785208591768, 5391.460853914734, 5403.405625381283, 5403.86490337729], "value": 5113.164051178723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.5888487465083, 717.7595505505656, 743.0229248538174, 1097.5335482419976, 1113.4766659669951, 33185.502217466754, 34273.0, 34440.311193776106, 34485.65514344856, 34498.827505862435, 36601.0, 37083.0, 37137.257254854885, 37159.81420092896, 37160.628393716055, 6702.497312701543, 6915.861682766342, 7001.334873187052, 7126.928730712679, 7153.928460715379, 6859.9314006859795, 6931.133608298963, 6974.965125174367, 6977.720891164347, 6980.476464265201, 6922.342377474157, 6952.409045231161, 6987.1266091738535, 6992.160940687125, 6996.195437524673, 6888.896666550006, 6905.343992320722, 6924.861502769942, 6925.37671609555, 6952.443804495628, 6768.221654509745, 6768.323167683241, 6803.65981700913, 6829.93170068298, 6842.794716158523, 33153.83423082869, 33204.00387988364, 33387.0, 33547.83226083854, 33706.32587348264, 3068.6777888321626, 3127.937441251185, 3131.3580715953176, 3140.2149462634343, 3144.2296637323775, 24613.66170213827, 24773.380665483328, 24778.132765353308, 24871.378215544577, 24875.751242487524, 2528.5954247320524, 2558.373198566363, 2558.833675811085, 2567.6020216866414, 2589.8446093234465, 127831.0, 128135.0, 135295.999999999, 146564.0, 147809.0, 40556.0, 40761.0, 40800.79599601983, 40927.0, 40935.7953210232, 42196.0, 42555.148897022504, 42561.78719106385, 42584.78707606504, 42655.78672106682, 13098.672533186747, 13139.802902956464, 13188.47246110164, 13221.801672974912, 13223.0, 10635.0960168385, 10675.199360048027, 10683.519241634145, 10693.0, 10711.196660250356, 12845.61463156088, 12941.935290323489, 12993.740125197632, 13031.218126912416, 13171.2755798432, 5307.124324486494, 5398.541124004425, 5481.698506582096, 5503.0, 5540.501354878, 839.6263662670053, 873.7422460374078, 876.2070326354659, 893.9865902011475, 928.8420968435382, 21511.816850073083, 21516.0, 21655.78344216569, 21769.455763606038, 21822.0, 974.7806743482802, 985.5269470654126, 999.6101520407047, 1002.834532302162, 1005.9295849290479, 10977.39624320654, 11244.212905096729, 11468.541258349573, 11486.368249746343, 11552.537898484135, 174742.0, 175364.0, 176001.0, 176543.0, 176547.0, 42961.35557966633, 43095.569044309785, 43183.78408107939, 43225.0, 43255.78372108119, 1176.9229645998262, 1228.2753175626424, 1234.2902830872285, 1235.0490122605722, 1236.8701286364983, 19878.60242795165, 20596.794032060086, 21751.347459576238, 24522.87738561296, 24891.51084891569, 37812.08442902515, 37915.0, 37969.24061518809, 38002.80998594989, 38197.23605527818, 141791.29104354413, 142042.0, 142323.0, 142352.0, 142512.0, 28085.157445276673, 30450.390992180477, 30458.23854403569, 30458.543121853632, 30634.84682576573, 36499.63500364962, 36978.6302136986, 37548.616735155636, 37864.24271514499, 38360.61639383682, 28503.28741781472, 28737.85631071831, 29088.56367154452, 29280.0, 30143.38279406485, 27584.862075689492, 27911.441771164868, 28097.71902280951, 28584.0, 29212.853935730185, 30332.0, 30781.69218307788, 31212.375752485277, 31252.687473125887, 31329.770480984775, 27238.0, 27564.0, 27594.5860812092, 27746.306342341602, 28580.285492862015, 20287.391378258675, 22332.77667223307, 22450.0, 22742.658860116782, 22825.543489129792], "value": 14742.419925187416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.19255947628955, 395.30821063139507, 401.2777001397484, 408.5628377635929, 414.1323926374245, 13564.253966031863, 14048.227347495884, 18251.361202357904, 18877.905610471946, 18910.90544547277, 18743.90628046858, 19539.511512212168, 19552.413427597196, 19561.0, 19576.412707618758, 5417.26866872973, 5579.023670857604, 5579.553635709133, 5583.916241256385, 5586.385497595261, 5479.397266300703, 5551.306086739158, 5564.888702225953, 5578.0517312056845, 5578.665280083188, 5510.862228444281, 5531.032069387861, 5549.472800083986, 5557.305336832896, 5562.0, 5291.0, 5410.161424979135, 5440.891182176374, 5447.373552041487, 5451.727413629343, 4857.587105096071, 4858.489858564871, 4860.3195552622665, 4861.927071093936, 4887.780049897763, 22370.77629223703, 22627.773722262733, 22734.545309093726, 22737.88631056834, 22778.772212277996, 1619.5465269724496, 1653.5700717813336, 1656.097426902329, 1656.1967445788782, 1658.9751153732705, 14838.925805371013, 15028.248587570688, 15440.073595584301, 15514.922425387913, 15549.922250388676, 1989.9851075951224, 2010.2662528177257, 2015.133492598182, 2023.5851650411778, 2105.884176370299, 111104.4444777779, 112934.43532782365, 113854.0, 113932.0, 114268.42865785617, 9621.0, 10495.317804342845, 10547.84178237327, 10835.945820271007, 10969.945150274198, 14761.114333140045, 14771.926140369229, 14809.777853332209, 14822.407103715947, 14848.5545433635, 7552.207018263113, 7677.424193185533, 7724.382049436032, 7910.9604451977375, 7939.20607939213, 7352.926470735331, 7383.889241661379, 7428.62856857155, 7448.180700122982, 7536.962315188389, 7038.225795162528, 7103.254158313406, 7139.416750666674, 7207.486427850105, 7306.123265208103, 1900.667383207933, 1922.0, 1968.9901550492157, 2047.078814533466, 2144.5925274197853, 828.1304630138451, 868.4745728833965, 884.8849649545518, 900.3427497926419, 900.8783814185132, 17324.653506930044, 17442.56393590145, 17645.205965731573, 17889.28442862297, 18122.637547249244, 870.4255191573658, 884.3279107878059, 890.5591732092655, 904.4799240436776, 913.5614904845711, 9410.670626528039, 9431.622735090657, 9600.471974041355, 9622.807543849083, 9626.95186524063, 373269.0, 380586.0, 380833.0, 381903.0, 382259.0, 88900.0, 89943.55028224816, 90309.54845225732, 90878.09121908696, 91101.54449227844, 1020.5152552537634, 1036.0985942230157, 1064.7284942339809, 1067.594314160614, 1067.8718553773442, 14916.62708432298, 15054.0, 15371.769423458882, 15612.141332226382, 15964.68070638604, 42578.0, 43029.56970430381, 43452.782736087385, 43902.34146487741, 45077.32384014308, 52258.73870630775, 52382.0, 52401.7379913098, 52714.0, 52730.472695272554, 9257.166854982814, 9376.156145946898, 9445.622175112918, 9521.523923803921, 9525.618975240914, 11431.199816012799, 12042.518299268282, 16033.67932641364, 16057.357705691642, 16124.516264512084, 12117.939410302892, 12769.0, 12932.353382331034, 12938.741225175256, 12941.870581294443, 12286.815697764361, 12583.748325033264, 12625.431855566338, 12746.808797868225, 12787.680307992374, 12755.93622031884, 12853.036022298553, 12994.870051299366, 13002.154859934075, 13467.0, 9368.765780855532, 9427.434353938786, 9434.198093162158, 9441.905580944103, 9455.385399948982, 13278.53525126616, 13365.866341336463, 13453.798193026916, 13466.192028478323, 13502.594922152352], "value": 9244.233454167344, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.665658600471, 1320.9537666181686, 1329.5213723059703, 1331.8202042724242, 1334.3328335832084, 9249.167574918256, 9673.371230869989, 9685.079917407853, 10023.148032417235, 10232.283740138193, 10024.198064154869, 10200.081992620662, 10223.795524089532, 10257.948710256456, 10266.435346055963, 2038.7859274776158, 2087.6137914485794, 2088.6553718636405, 2089.039042040663, 2091.205341970057, 1993.7208790769305, 2034.104993802722, 2039.5818857134252, 2044.3458093410115, 2054.2296638760463, 1995.9201631934704, 2017.959640807183, 2028.2900984655325, 2030.9492262693477, 2037.480442487171, 1957.8433725302013, 1963.8330741886957, 1976.1403789351607, 1976.9110390032483, 1983.0283161251027, 1762.4536393717988, 1817.4002579148848, 1896.706010568364, 1910.7898131205557, 1936.6126774644986, 9752.658656947044, 9992.850107248398, 10005.549750261256, 10025.59897604095, 10037.79924401508, 5226.686398816083, 5468.453154684539, 5472.753726082336, 5483.287172667568, 5486.3690675572425, 3191.888283910052, 3219.5492631031675, 3294.7364210863075, 3315.237495376077, 3322.9501557476415, 964.3731574476576, 967.4340510801189, 983.9754006149903, 992.4888682328607, 993.1657407777501, 14483.058601190889, 14649.340779665048, 14657.780133298009, 14665.48670796517, 14690.0, 4635.288356311528, 4670.6497012724185, 4699.953000469952, 4840.056189043174, 4848.490908454562, 11123.55505779776, 11134.0, 11204.159688023268, 11276.210665253517, 11427.885721142848, 5294.311739473844, 5400.081986062379, 5419.674819510842, 5422.511973922287, 5423.620346575781, 4870.878228044327, 4961.4046314441775, 4963.677360971526, 4979.950200498021, 4983.277424773388, 3854.5374555053572, 3876.6898648108086, 3943.723939324277, 3971.324874771296, 3987.601239876047, 1162.424914241208, 1171.226990186473, 1172.818213176959, 1190.220405634311, 1190.9344986025678, 702.796189105164, 722.5772922840198, 725.5066554742825, 726.12501935168, 741.9109706835214, 5433.510984011458, 5520.723963801875, 5553.667119891197, 5571.804986825523, 5649.491545760901, 504.8485454363676, 525.6583220906441, 528.582419888284, 530.125293266114, 532.5659587436227, 3847.1728578355787, 3849.5188101487315, 3908.296506628777, 3920.196359746245, 3965.365541513344, 12702.491900323883, 13032.80450793239, 13057.542985995444, 13092.214467131813, 13143.14569552976, 12509.937450312691, 12800.487980480862, 13076.803847942288, 13092.083554151119, 13117.0818042738, 7143.464240182007, 7346.375558077516, 7385.6307184640555, 7403.148637906602, 7405.888911666221, 5966.016991504248, 6123.418275263843, 6124.38756124384, 6190.164327815867, 6411.134496843053, 11504.367259800456, 11675.649730508097, 11816.291022538675, 11856.11079169083, 12001.699957501132, 11164.218504704593, 11237.49431275611, 11284.943575282072, 11333.716657083638, 11390.145739069769, 8350.916490835014, 8434.0, 8591.957040214758, 8626.5255410953, 8711.346649001476, 9054.094590540893, 9316.906830931604, 9333.300002499704, 9344.34589578723, 9346.859797103185, 7809.101953275446, 7830.33442157423, 7838.608069596383, 7891.84216315682, 8010.279074883056, 7857.096433909945, 7956.721514746956, 7965.163657816078, 8039.718609848627, 8063.314618257514, 6991.0, 7163.820904477429, 7208.207097219197, 7212.4590655699985, 7226.74706385274, 4925.507449255046, 4938.950610493849, 4939.5554400104165, 4946.109700253989, 5035.84892453227, 4995.200767877122, 5032.496750324938, 5113.7698803553185, 5152.793888244429, 5152.922706159336], "value": 4556.400451625206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.21545183832876, 349.1271820448878, 352.6315000824139, 353.55981802655697, 356.4777600814804, 5443.156310771837, 5593.244911936888, 5603.943960560393, 5634.408387119355, 5635.464630860072, 5399.19012148178, 5445.945540544593, 5464.207689884975, 5469.425710300421, 5494.230807686927, 4139.0753299715625, 4143.7513749175, 4150.9584904151025, 4152.460180176573, 4176.081262122329, 4120.711550191488, 4143.482064741907, 4156.750594964312, 4164.562720914306, 4166.854160104397, 4107.260693075245, 4121.855735049274, 4125.587441255881, 4131.9876630225635, 4139.958600413987, 4097.8770636880945, 4106.0761328700955, 4113.938290925638, 4126.360414135814, 4134.441850350195, 3594.946075808865, 3598.982005089958, 3605.8557657693923, 3617.077645200457, 3625.655562721537, 5425.484578964992, 5451.936872309901, 5455.918161227585, 5460.126379779216, 5494.36814766299, 4831.637627177941, 4841.370621819176, 4841.636877234187, 4854.2961270615915, 4865.537773911473, 5757.395473475309, 5783.190353350492, 5792.362840087587, 5798.565107616945, 5800.419958004208, 4041.4341992121126, 4045.251628448717, 4046.919061618751, 4075.9388609170887, 4090.6522945549664, 5929.258842644669, 6114.357992410777, 6169.969150154266, 6206.665566903138, 6250.811955989498, 4059.573744756817, 4113.773742444194, 4142.502899652061, 4145.0880806222585, 4154.5222299435345, 4194.706370554032, 4205.558416366299, 4209.894752631209, 4213.557576454428, 4225.598568136023, 4696.577308042292, 4814.542618451242, 4824.541668541483, 4855.247436647325, 4861.246506791453, 5833.724847309552, 5843.883122337529, 5845.473907348274, 5864.882702345929, 5875.294964604275, 1430.29915341484, 1435.1604311477693, 1440.517426662059, 1440.5246268731294, 1442.3293168676405, 936.2556767369957, 959.6257459590765, 973.090160699748, 974.3423189347304, 979.779549601334, 5010.549050585465, 5063.316442285594, 5075.441701412841, 5079.74601269935, 5091.163394774979, 6028.57799953999, 6054.212952316171, 6075.724097939394, 6077.179580756541, 6086.786962456293, 5036.219385995177, 5062.658395525189, 5065.924011139836, 5072.315237442972, 5074.746262686851, 3201.583794106751, 3228.499582564706, 3234.5956755405573, 3239.174010627275, 3244.286257023451, 5619.690916999522, 5633.605647604629, 5634.211210430543, 5645.717714114277, 5648.096304591246, 6167.444929956326, 6177.166082578884, 6182.196314479089, 6214.40963108504, 6228.968855155696, 5583.190437386637, 5603.635763675348, 5607.7476513556985, 5618.0, 5626.465485778845, 6008.969955150196, 6024.759009639565, 6025.87948241024, 6039.698015099315, 6054.9091763624465, 5903.2325797647745, 5904.704764761659, 5928.614640048383, 5936.347001829881, 5959.344472108151, 5260.631755777212, 5554.50009499147, 5612.130119831432, 5615.606907516435, 5624.156376543551, 4061.070991279119, 4099.077707515785, 4112.074783173762, 4112.09533902541, 4118.279301122232, 6056.6076399822705, 6057.002378430215, 6057.151998720271, 6065.423784740443, 6072.90890636632, 5673.8297851064535, 5827.125931110368, 5859.589828711949, 5885.352611212848, 5894.616849904743, 5867.589268751147, 5873.70778428745, 5888.735006924784, 5890.0, 5893.351731309467, 5747.3103227612955, 5752.453516915886, 5757.905997860393, 5760.6255593386295, 5766.94233057664, 5871.236739223874, 5876.882462350814, 5896.64620122794, 5926.259217597801, 5927.970360148344, 5661.518770904519, 5674.858128546819, 5677.858053548694, 5734.254546908875, 5735.225744524436], "value": 4345.021101350677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.501473982952, 737.9631018449077, 746.6117618838205, 756.6027835386421, 762.7635433015764, 13381.7992730109, 14027.719445611081, 14134.081284716487, 16575.751363729552, 18229.36197233097, 15090.47183348583, 15152.469663561778, 15254.161021143833, 15283.312250948706, 15381.538553843402, 893.2273583350404, 911.5168960450939, 911.7538264668535, 914.8581969794659, 915.1534830281996, 901.184428092574, 904.1094521895927, 924.1590152960807, 930.9069093090704, 934.3693007220133, 966.3332300712486, 968.1286841842327, 969.5249327829348, 969.9127078562927, 970.0929630795229, 945.716285114463, 949.9667511637094, 950.4439902656954, 956.5217391304348, 956.8038552096838, 704.9541779784349, 706.0679902528664, 708.1643660480631, 709.0888208651909, 710.7086094701148, 13899.305034748222, 13899.652508687263, 14020.158790472604, 14063.0, 14096.718065638732, 15084.924575377163, 15312.0, 15379.692406151926, 15401.460948866736, 15408.075515468996, 12296.631101066982, 12467.688307792378, 12618.873811261861, 12625.242485450903, 12741.490340386466, 2993.760499160084, 3011.533212352067, 3019.2753739102677, 3024.6370435547656, 3025.5461680747844, 86600.56699716461, 88080.0, 89300.0, 89734.5513272436, 90266.0, 11494.310341379543, 12272.754544909052, 12442.937785311016, 12450.377481125908, 12675.429605667767, 19453.805461945198, 19748.50628734293, 19756.407307780788, 19761.703574446394, 19810.306639267557, 6028.2766068072115, 6088.512918966472, 6191.721372538246, 6226.5641405101205, 6252.843678908063, 2778.19432364612, 2902.2309088091674, 2917.9854100729362, 2981.4782413077623, 2983.2690990707415, 3793.255102652811, 3843.3466310727244, 3899.2201559688174, 3900.258950799339, 3902.434147048662, 730.0071902212986, 744.181400459501, 759.8670232709254, 764.1365257259262, 766.5400759544228, 558.6592178770946, 582.0774073094193, 589.3340525206575, 598.4344794169555, 607.6323824086364, 9477.720507731507, 9762.609495620238, 10029.498525073863, 10292.228082893813, 10776.78446431067, 564.94350564944, 566.2242727463401, 572.2703552969997, 588.0561698473973, 599.2090440618429, 4215.683823713172, 4386.583274588909, 4395.626371758436, 4414.514403415622, 4515.774211289422, 77747.61126194333, 80058.0, 82716.0, 89963.55018224867, 91313.0, 64730.67634661797, 65006.34993650003, 65102.674486627264, 65192.67403662951, 66582.99999999903, 56855.715721421126, 59689.701551492835, 59700.0, 60512.0, 61803.38196618066, 10152.0, 10419.53112109972, 11119.555217791521, 11370.602028928948, 11485.483153257956, 26581.734182657925, 26750.866245668647, 27180.864095679393, 28401.147965561067, 28444.431111377242, 50096.0, 50444.49555504398, 50489.74755126201, 51837.48162518327, 52065.7396713014, 13022.739545208853, 13092.083554151499, 13246.867531324564, 13418.93290533541, 13558.93220533891, 15774.526764197093, 16198.757018644494, 16464.0, 16777.412790552273, 17493.775435719886, 13005.154664946747, 13514.79727804064, 13725.0, 15362.0, 15662.843371566138, 14914.627134321729, 14944.925275373553, 15503.0, 15709.135997519788, 15765.763513547077, 13919.512817051354, 13960.673735995064, 15308.61728456753, 15312.693746125238, 15390.307436165176, 9803.803923921625, 9842.655507057505, 10165.695029149138, 10230.232732545237, 10522.526486308288, 11093.389863557582, 11368.134834156426, 11598.362090085126, 11917.463714132711, 12017.879821201675], "value": 7141.553981469987, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 108.0, 111.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 123.0, 162.0, 124.0, 123.0, 123.0, 129.0, 156.0, 125.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 173.0, 167.0, 169.0, 170.0, 168.0, 162.0, 163.0, 163.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 110.0, 74.0, 81.0, 75.0, 75.0, 94.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 108.0, 85.0, 88.0, 83.0, 95.0, 83.0, 82.0, 107.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 118.0, 115.0, 118.0, 114.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 150.0, 150.0, 149.0, 152.0, 150.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 103.0, 98.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 54.0, 58.0, 56.0, 57.0, 56.0, 57.0, 58.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 56.0, 55.0, 55.0, 55.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 86.0, 87.0, 86.0, 87.0, 86.0, 126.0, 88.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 136.0, 135.0, 137.0, 129.0, 131.0, 129.0, 135.0, 134.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 201.0, 194.0, 194.0, 196.0, 198.0, 196.0, 197.0, 186.0, 199.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 72.0, 75.0, 75.0, 72.0, 72.0, 71.0, 72.0], "value": 73.8, "unit": "score"}]}]} 09:55:05 INFO - Return code: 0 09:55:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:55:05 INFO - # TBPL SUCCESS # 09:55:05 INFO - Running post-action listener: _resource_record_post_action 09:55:05 INFO - [mozharness: 2017-06-01 16:55:05.110963Z] Finished run-tests step (success) 09:55:05 INFO - Running post-run listener: _resource_record_post_run 09:55:05 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 425984; Write bytes: 421515264; Read time: 60; Write time: 286072 09:55:05 INFO - TinderboxPrint: CPU usage
12.7% 09:55:05 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 60 09:55:05 INFO - TinderboxPrint: I/O write bytes / time
421,515,264 / 286,072 09:55:05 INFO - TinderboxPrint: CPU idle
8,774.2 (87.3%) 09:55:05 INFO - TinderboxPrint: CPU user
1,219.7 (12.1%) 09:55:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:55:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113356800; Read time: 0; Write time: 100216 09:55:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:55:05 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 421888; Write bytes: 308158464; Read time: 44; Write time: 185856 09:55:05 INFO - Running post-run listener: _upload_blobber_files 09:55:05 INFO - Blob upload gear active. 09:55:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:55:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:07 INFO - (blobuploader) - INFO - Done attempting. 09:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:08 INFO - (blobuploader) - INFO - Done attempting. 09:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:08 INFO - (blobuploader) - INFO - Done attempting. 09:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:12 INFO - (blobuploader) - INFO - Done attempting. 09:55:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:55:12 INFO - Return code: 0 09:55:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:55:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:55:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0912bca7945d99b6884326bd384b6d0419dbaebdeeeeea77408c99e4dd2e297b80aa325cb2f99361dbce0d9316c8947fe2cb7d0d0f4e20035a5ee55036626f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/846ef3ac1c8bd30b248089b1abb9b51af9d9de384ea963f278a7a2dda7f43fa6b41d913ed8c243636d923fcbd0088704de60902a40a924154eb5005043e2e178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc8d6e08726df7c9aee2b88a343b591282f81f60d5f1ecb5b272619a128de823cb983eeb5989a16911a24dd7c3e7756258f81f7784ef822faf37063425219426", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca73a19b39fe8de323452afe43135a0018197afbc381b2aed59c998fdcda061720c163fb8f7dcfbcef656ac6c709164b9b611727135b71195bcc645671c20068"} 09:55:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:55:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:55:12 INFO - Contents: 09:55:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0912bca7945d99b6884326bd384b6d0419dbaebdeeeeea77408c99e4dd2e297b80aa325cb2f99361dbce0d9316c8947fe2cb7d0d0f4e20035a5ee55036626f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/846ef3ac1c8bd30b248089b1abb9b51af9d9de384ea963f278a7a2dda7f43fa6b41d913ed8c243636d923fcbd0088704de60902a40a924154eb5005043e2e178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc8d6e08726df7c9aee2b88a343b591282f81f60d5f1ecb5b272619a128de823cb983eeb5989a16911a24dd7c3e7756258f81f7784ef822faf37063425219426", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca73a19b39fe8de323452afe43135a0018197afbc381b2aed59c998fdcda061720c163fb8f7dcfbcef656ac6c709164b9b611727135b71195bcc645671c20068"} 09:55:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:55:12 INFO - Copying logs to upload dir... 09:55:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:55:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.589810 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-01 09:55:12.340877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:55:12.345145) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0912bca7945d99b6884326bd384b6d0419dbaebdeeeeea77408c99e4dd2e297b80aa325cb2f99361dbce0d9316c8947fe2cb7d0d0f4e20035a5ee55036626f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/846ef3ac1c8bd30b248089b1abb9b51af9d9de384ea963f278a7a2dda7f43fa6b41d913ed8c243636d923fcbd0088704de60902a40a924154eb5005043e2e178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc8d6e08726df7c9aee2b88a343b591282f81f60d5f1ecb5b272619a128de823cb983eeb5989a16911a24dd7c3e7756258f81f7784ef822faf37063425219426", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca73a19b39fe8de323452afe43135a0018197afbc381b2aed59c998fdcda061720c163fb8f7dcfbcef656ac6c709164b9b611727135b71195bcc645671c20068"} build_url:https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/aZiu00IFQfi-S6xLljRYbw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0912bca7945d99b6884326bd384b6d0419dbaebdeeeeea77408c99e4dd2e297b80aa325cb2f99361dbce0d9316c8947fe2cb7d0d0f4e20035a5ee55036626f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/846ef3ac1c8bd30b248089b1abb9b51af9d9de384ea963f278a7a2dda7f43fa6b41d913ed8c243636d923fcbd0088704de60902a40a924154eb5005043e2e178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc8d6e08726df7c9aee2b88a343b591282f81f60d5f1ecb5b272619a128de823cb983eeb5989a16911a24dd7c3e7756258f81f7784ef822faf37063425219426", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca73a19b39fe8de323452afe43135a0018197afbc381b2aed59c998fdcda061720c163fb8f7dcfbcef656ac6c709164b9b611727135b71195bcc645671c20068"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:55:12.377537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:55:12.378157) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1496333027.489555-772516560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004736 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:55:12.465920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:55:12.466482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:55:12.467025) ========= ========= Total master_lag: 0.21 =========