builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1496164884.61 results: success (0) revision: 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.605340) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.605789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.606071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.621605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.621892) ========= 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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 10:21:24-- 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% 448K=0.03s 2017-05-30 10:21:24 (448 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.754794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.755166) ========= 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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.804936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:24.805274) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b --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 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b --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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 10:21:24,901 truncating revision to first 12 chars 2017-05-30 10:21:24,901 Setting DEBUG logging. 2017-05-30 10:21:24,901 attempt 1/10 2017-05-30 10:21:24,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39d5cc0fda5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 10:21:25,216 unpacking tar archive at: mozilla-central-39d5cc0fda5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:25.444850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:25.445199) ========= script_repo_revision: 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:25.445576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:25.445839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 10:21:25.453803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-30 10:21:25.454108) ========= /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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:25 INFO - MultiFileLogger online at 20170530 10:21:25 in /builds/slave/test 10:21:25 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 10:21:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:25 INFO - {'append_to_log': False, 10:21:25 INFO - 'base_work_dir': '/builds/slave/test', 10:21:25 INFO - 'blob_upload_branch': 'Firefox', 10:21:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:25 INFO - 'branch': 'Firefox', 10:21:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:25 INFO - 'config_files': ('talos/linux_config.py',), 10:21:25 INFO - 'default_actions': ('clobber', 10:21:25 INFO - 'read-buildbot-config', 10:21:25 INFO - 'download-and-extract', 10:21:25 INFO - 'populate-webroot', 10:21:25 INFO - 'create-virtualenv', 10:21:25 INFO - 'install', 10:21:25 INFO - 'setup-mitmproxy', 10:21:25 INFO - 'run-tests'), 10:21:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:25 INFO - 'download_minidump_stackwalk': True, 10:21:25 INFO - 'download_symbols': 'ondemand', 10:21:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:25 INFO - 'gecko_profile': False, 10:21:25 INFO - 'gecko_profile_interval': 0, 10:21:25 INFO - 'installer_path': 'installer.exe', 10:21:25 INFO - 'log_level': 'info', 10:21:25 INFO - 'log_name': 'talos', 10:21:25 INFO - 'log_to_console': True, 10:21:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:25 INFO - 'opt_config_files': (), 10:21:25 INFO - 'pip_index': False, 10:21:25 INFO - 'suite': 'dromaeojs-e10s', 10:21:25 INFO - 'system_bits': '32', 10:21:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:25 INFO - 'title': 'talos-linux64-ix-032', 10:21:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:25 INFO - 'use_talos_json': True, 10:21:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:25 INFO - 'work_dir': 'build'} 10:21:25 INFO - [mozharness: 2017-05-30 17:21:25.648280Z] Running clobber step. 10:21:25 INFO - Running pre-action listener: _resource_record_pre_action 10:21:25 INFO - Running main action method: clobber 10:21:25 INFO - rmtree: /builds/slave/test/build 10:21:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:26 INFO - Running post-action listener: _resource_record_post_action 10:21:26 INFO - [mozharness: 2017-05-30 17:21:26.674344Z] Finished clobber step (success) 10:21:26 INFO - [mozharness: 2017-05-30 17:21:26.674447Z] Running read-buildbot-config step. 10:21:26 INFO - Running pre-action listener: _resource_record_pre_action 10:21:26 INFO - Running main action method: read_buildbot_config 10:21:26 INFO - Using buildbot properties: 10:21:26 INFO - { 10:21:26 INFO - "project": "", 10:21:26 INFO - "product": "firefox", 10:21:26 INFO - "who": "ryanvm@gmail.com", 10:21:26 INFO - "installer_path": "public/build/target.tar.bz2", 10:21:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:21:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:21:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:21:26 INFO - "stage_platform": "linux64-stylosequential", 10:21:26 INFO - "basedir": "/builds/slave/test", 10:21:26 INFO - "buildnumber": 33, 10:21:26 INFO - "platform": "ubuntu64_hw_styloseq", 10:21:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:21:26 INFO - "slavebuilddir": "test", 10:21:26 INFO - "taskId": "XRCSwmalQfq6mraEOozgvw", 10:21:26 INFO - "branch": "mozilla-central", 10:21:26 INFO - "script_repo_revision": "production", 10:21:26 INFO - "revision": "39d5cc0fda5e16c49a59d29d4ca186a5534cc88b", 10:21:26 INFO - "slavename": "talos-linux64-ix-032", 10:21:26 INFO - "repo_path": "mozilla-central" 10:21:26 INFO - } 10:21:26 INFO - Finding installer, test and symbols from parent task. 10:21:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XRCSwmalQfq6mraEOozgvw'}, attempt #1 10:21:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XRCSwmalQfq6mraEOozgvw'}, attempt #1 10:21:27 INFO - Task dependencies: FzvVxojLSNqrHbcosBw55w 10:21:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w'}, attempt #1 10:21:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 10:21:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/test_packages.json 10:21:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.crashreporter-symbols.zip 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - [mozharness: 2017-05-30 17:21:28.357630Z] Finished read-buildbot-config step (success) 10:21:28 INFO - [mozharness: 2017-05-30 17:21:28.357852Z] Running download-and-extract step. 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: download_and_extract 10:21:28 INFO - mkdir: /builds/slave/test/build/tests 10:21:28 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')]} 10:21:28 INFO - trying https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.test_packages.json 10:21:28 INFO - Downloading https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:21:28 INFO - Downloaded 986 bytes. 10:21:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:21:28 INFO - Using the following test package requirements: 10:21:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:21:28 INFO - u'common': [u'target.common.tests.zip'], 10:21:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:21:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:21:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:21:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:21:28 INFO - u'mozbase': [u'target.common.tests.zip'], 10:21:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:21:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:21:28 INFO - u'web-platform': [u'target.common.tests.zip', 10:21:28 INFO - u'target.web-platform.tests.zip'], 10:21:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:21:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:21:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip 10:21:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:21:28 INFO - Fetch https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip into memory 10:21:30 INFO - Content-Length response header: 63528626 10:21:30 INFO - Bytes received: 63528626 10:21:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip 10:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.common.tests.zip into memory 10:21:42 INFO - Content-Length response header: 63528626 10:21:42 INFO - Bytes received: 63528626 10:21:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.talos.tests.zip 10:21:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:21:54 INFO - Fetch https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.talos.tests.zip into memory 10:21:54 INFO - Content-Length response header: 14447425 10:21:54 INFO - Bytes received: 14447425 10:21: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')]} 10:21:55 INFO - trying https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 10:21:55 INFO - Downloading https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:21:56 INFO - Downloaded 55777745 bytes. 10:21:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 10:21:56 INFO - mkdir: /builds/slave/test/properties 10:21:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:56 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:56 INFO - Contents: 10:21:56 INFO - build_url:https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 10:21:56 INFO - Running post-action listener: _resource_record_post_action 10:21:56 INFO - Running post-action listener: set_extra_try_arguments 10:21:56 INFO - [mozharness: 2017-05-30 17:21:56.215401Z] Finished download-and-extract step (success) 10:21:56 INFO - [mozharness: 2017-05-30 17:21:56.215498Z] Running populate-webroot step. 10:21:56 INFO - Running pre-action listener: _resource_record_pre_action 10:21:56 INFO - Running main action method: populate_webroot 10:21:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:56 INFO - '--tppagecycles', 10:21:56 INFO - '7'], 10:21:56 INFO - 'tests': ['tsvgm']}}, 10:21:56 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['damp', 'tps']}, 10:21:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'tests': ['damp', 'tps']}, 10:21:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['dromaeo_dom']}, 10:21:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:21:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:21:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:21:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['a11yr', 10:21:56 INFO - 'ts_paint', 10:21:56 INFO - 'tpaint', 10:21:56 INFO - 'sessionrestore', 10:21:56 INFO - 'sessionrestore_no_auto_restore', 10:21:56 INFO - 'tabpaint']}, 10:21:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:21:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:21:56 INFO - 'bloom_basic_ref']}, 10:21:56 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:21:56 INFO - 'talos_options': ['--mitmproxy', 10:21:56 INFO - 'mitmproxy-recording-1.mp', 10:21:56 INFO - '--firstNonBlankPaint'], 10:21:56 INFO - 'tests': ['Quantum_1']}, 10:21:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['tsvgx', 10:21:56 INFO - 'tsvgr_opacity', 10:21:56 INFO - 'tart', 10:21:56 INFO - 'tscrollx', 10:21:56 INFO - 'cart', 10:21:56 INFO - 'tsvg_static']}, 10:21:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:56 INFO - 'tsvgr_opacity', 10:21:56 INFO - 'tart', 10:21:56 INFO - 'tscrollx', 10:21:56 INFO - 'cart', 10:21:56 INFO - 'tsvg_static']}, 10:21:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'talos_options': ['--disable-e10s'], 10:21:56 INFO - 'tests': ['tp5o']}, 10:21:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:21:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'talos_options': ['--disable-e10s', 10:21:56 INFO - '--xperf_path', 10:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:56 INFO - 'tests': ['tp5n']}, 10:21:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:21:56 INFO - 'talos_options': ['--xperf_path', 10:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:56 INFO - 'tests': ['tp5n']}}, 10:21:56 INFO - 'talos.zip': {'path': '', 10:21:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:56 INFO - Running post-action listener: _resource_record_post_action 10:21:56 INFO - [mozharness: 2017-05-30 17:21:56.229863Z] Finished populate-webroot step (success) 10:21:56 INFO - [mozharness: 2017-05-30 17:21:56.229957Z] Running create-virtualenv step. 10:21:56 INFO - Running pre-action listener: _resource_record_pre_action 10:21:56 INFO - Running main action method: create_virtualenv 10:21:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:56 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 10:21:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:56 INFO - Using real prefix '/usr' 10:21:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:58 INFO - Installing pip.................done. 10:21:58 INFO - Return code: 0 10:21:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:21:59 INFO - Reading from file tmpfile_stdout 10:21:59 INFO - Output received: 10:21:59 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) 10:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:59 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')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 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')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'DISPLAY': ':0', 10:21:59 INFO - 'HOME': '/home/cltbld', 10:21:59 INFO - 'LANG': 'en_US.UTF-8', 10:21:59 INFO - 'LANGUAGE': 'en_US:en', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MAIL': '/var/mail/cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SHLVL': '1', 10:21:59 INFO - 'TERM': 'linux', 10:21:59 INFO - 'TMOUT': '86400', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - '_': '/tools/buildbot/bin/python'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 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 10:21:59 INFO - Cleaning up... 10:21:59 INFO - Return code: 0 10:21:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21:59 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')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 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')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'DISPLAY': ':0', 10:21:59 INFO - 'HOME': '/home/cltbld', 10:21:59 INFO - 'LANG': 'en_US.UTF-8', 10:21:59 INFO - 'LANGUAGE': 'en_US:en', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MAIL': '/var/mail/cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SHLVL': '1', 10:21:59 INFO - 'TERM': 'linux', 10:21:59 INFO - 'TMOUT': '86400', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - '_': '/tools/buildbot/bin/python'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 INFO - Downloading/unpacking psutil>=3.1.1 10:21:59 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 10:21:59 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 10:21:59 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 10:21:59 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 10:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:00 INFO - Installing collected packages: psutil 10:22:00 INFO - Running setup.py install for psutil 10:22:00 INFO - building 'psutil._psutil_linux' extension 10:22:00 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 10:22:00 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 10:22:00 INFO - building 'psutil._psutil_posix' extension 10:22:00 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 10:22:01 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 10:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:01 INFO - Successfully installed psutil 10:22:01 INFO - Cleaning up... 10:22:01 INFO - Return code: 0 10:22:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:22:01 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')]} 10:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:01 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')]} 10:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:01 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:01 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 10:22:01 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 10:22:01 INFO - Using env: {'DISPLAY': ':0', 10:22:01 INFO - 'HOME': '/home/cltbld', 10:22:01 INFO - 'LANG': 'en_US.UTF-8', 10:22:01 INFO - 'LANGUAGE': 'en_US:en', 10:22:01 INFO - 'LOGNAME': 'cltbld', 10:22:01 INFO - 'MAIL': '/var/mail/cltbld', 10:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:01 INFO - 'MOZ_NO_REMOTE': '1', 10:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:01 INFO - 'NO_EM_RESTART': '1', 10:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:01 INFO - 'PWD': '/builds/slave/test', 10:22:01 INFO - 'SHELL': '/bin/bash', 10:22:01 INFO - 'SHLVL': '1', 10:22:01 INFO - 'TERM': 'linux', 10:22:01 INFO - 'TMOUT': '86400', 10:22:01 INFO - 'USER': 'cltbld', 10:22:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:01 INFO - '_': '/tools/buildbot/bin/python'} 10:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:22:01 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 10:22:01 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 10:22:01 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 10:22:01 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 10:22:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:22:02 INFO - Installing collected packages: mozsystemmonitor 10:22:02 INFO - Running setup.py install for mozsystemmonitor 10:22:02 INFO - Successfully installed mozsystemmonitor 10:22:02 INFO - Cleaning up... 10:22:02 INFO - Return code: 0 10:22:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:22:02 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')]} 10:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:02 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')]} 10:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:02 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:02 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 10:22:02 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 10:22:02 INFO - Using env: {'DISPLAY': ':0', 10:22:02 INFO - 'HOME': '/home/cltbld', 10:22:02 INFO - 'LANG': 'en_US.UTF-8', 10:22:02 INFO - 'LANGUAGE': 'en_US:en', 10:22:02 INFO - 'LOGNAME': 'cltbld', 10:22:02 INFO - 'MAIL': '/var/mail/cltbld', 10:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:02 INFO - 'MOZ_NO_REMOTE': '1', 10:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:02 INFO - 'NO_EM_RESTART': '1', 10:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:02 INFO - 'PWD': '/builds/slave/test', 10:22:02 INFO - 'SHELL': '/bin/bash', 10:22:02 INFO - 'SHLVL': '1', 10:22:02 INFO - 'TERM': 'linux', 10:22:02 INFO - 'TMOUT': '86400', 10:22:02 INFO - 'USER': 'cltbld', 10:22:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:02 INFO - '_': '/tools/buildbot/bin/python'} 10:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:22: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 10:22: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 10:22: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 10:22: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 10:22:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:22:03 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 10:22:03 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 10:22:03 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 10:22:03 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 10:22:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:04 INFO - warning: no files found matching '*.txt' 10:22:04 INFO - no previously-included directories found matching 'build' 10:22:04 INFO - no previously-included directories found matching 'dist' 10:22:04 INFO - no previously-included directories found matching '.git*' 10:22:04 INFO - Installing collected packages: jsonschema, functools32 10:22:04 INFO - Running setup.py install for functools32 10:22:04 INFO - warning: no files found matching '*.txt' 10:22:04 INFO - no previously-included directories found matching 'build' 10:22:04 INFO - no previously-included directories found matching 'dist' 10:22:04 INFO - no previously-included directories found matching '.git*' 10:22:04 INFO - Successfully installed jsonschema functools32 10:22:04 INFO - Cleaning up... 10:22:04 INFO - Return code: 0 10:22:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:22:04 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')]} 10:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:04 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')]} 10:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:04 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:04 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 10:22:04 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 10:22:04 INFO - Using env: {'DISPLAY': ':0', 10:22:04 INFO - 'HOME': '/home/cltbld', 10:22:04 INFO - 'LANG': 'en_US.UTF-8', 10:22:04 INFO - 'LANGUAGE': 'en_US:en', 10:22:04 INFO - 'LOGNAME': 'cltbld', 10:22:04 INFO - 'MAIL': '/var/mail/cltbld', 10:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:04 INFO - 'MOZ_NO_REMOTE': '1', 10:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:04 INFO - 'NO_EM_RESTART': '1', 10:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:04 INFO - 'PWD': '/builds/slave/test', 10:22:04 INFO - 'SHELL': '/bin/bash', 10:22:04 INFO - 'SHLVL': '1', 10:22:04 INFO - 'TERM': 'linux', 10:22:04 INFO - 'TMOUT': '86400', 10:22:04 INFO - 'USER': 'cltbld', 10:22:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:04 INFO - '_': '/tools/buildbot/bin/python'} 10:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:22:04 INFO - Cleaning up... 10:22:04 INFO - Return code: 0 10:22:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:22:04 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')]} 10:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:04 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')]} 10:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:04 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:04 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 10:22:04 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 10:22:04 INFO - Using env: {'DISPLAY': ':0', 10:22:04 INFO - 'HOME': '/home/cltbld', 10:22:04 INFO - 'LANG': 'en_US.UTF-8', 10:22:04 INFO - 'LANGUAGE': 'en_US:en', 10:22:04 INFO - 'LOGNAME': 'cltbld', 10:22:04 INFO - 'MAIL': '/var/mail/cltbld', 10:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:04 INFO - 'MOZ_NO_REMOTE': '1', 10:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:04 INFO - 'NO_EM_RESTART': '1', 10:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:04 INFO - 'PWD': '/builds/slave/test', 10:22:04 INFO - 'SHELL': '/bin/bash', 10:22:04 INFO - 'SHLVL': '1', 10:22:04 INFO - 'TERM': 'linux', 10:22:04 INFO - 'TMOUT': '86400', 10:22:04 INFO - 'USER': 'cltbld', 10:22:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:04 INFO - '_': '/tools/buildbot/bin/python'} 10:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:22: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 10:22: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 10:22: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 10:22: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 10:22:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:22:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:22:05 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 10:22:05 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 10:22:05 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 10:22:05 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 10:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:22:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 INFO - Downloading docopt-0.6.1.tar.gz 10:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:22:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:22:06 INFO - Running setup.py install for blobuploader 10:22:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:22:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:22:06 INFO - Running setup.py install for requests 10:22:06 INFO - Running setup.py install for docopt 10:22:07 INFO - Successfully installed blobuploader requests docopt 10:22:07 INFO - Cleaning up... 10:22:07 INFO - Return code: 0 10:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:07 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')]} 10:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:07 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')]} 10:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:07 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:07 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 10:22:07 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 10:22:07 INFO - Using env: {'DISPLAY': ':0', 10:22:07 INFO - 'HOME': '/home/cltbld', 10:22:07 INFO - 'LANG': 'en_US.UTF-8', 10:22:07 INFO - 'LANGUAGE': 'en_US:en', 10:22:07 INFO - 'LOGNAME': 'cltbld', 10:22:07 INFO - 'MAIL': '/var/mail/cltbld', 10:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:07 INFO - 'MOZ_NO_REMOTE': '1', 10:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:07 INFO - 'NO_EM_RESTART': '1', 10:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:07 INFO - 'PWD': '/builds/slave/test', 10:22:07 INFO - 'SHELL': '/bin/bash', 10:22:07 INFO - 'SHLVL': '1', 10:22:07 INFO - 'TERM': 'linux', 10:22:07 INFO - 'TMOUT': '86400', 10:22:07 INFO - 'USER': 'cltbld', 10:22:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:07 INFO - '_': '/tools/buildbot/bin/python'} 10:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:07 INFO - Running setup.py (path:/tmp/pip-4lg8V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:07 INFO - Running setup.py (path:/tmp/pip-oSEIp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:07 INFO - Running setup.py (path:/tmp/pip-GM8JsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:07 INFO - Running setup.py (path:/tmp/pip-WQYPMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:07 INFO - Running setup.py (path:/tmp/pip-CqYSXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:07 INFO - Running setup.py (path:/tmp/pip-5ipyCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:07 INFO - Running setup.py (path:/tmp/pip-QwH5xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:07 INFO - Running setup.py (path:/tmp/pip-9wqFp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:07 INFO - Running setup.py (path:/tmp/pip-9YX9Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:07 INFO - Running setup.py (path:/tmp/pip-rZn6t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:07 INFO - Running setup.py (path:/tmp/pip-6cRyOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:08 INFO - Running setup.py (path:/tmp/pip-DSiDE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:08 INFO - Running setup.py (path:/tmp/pip-UGQ_3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:08 INFO - Running setup.py (path:/tmp/pip-6xowuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:08 INFO - Running setup.py (path:/tmp/pip-bo9bFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:08 INFO - Running setup.py (path:/tmp/pip-5K56bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:08 INFO - Running setup.py (path:/tmp/pip-LM6Jmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:22:08 INFO - Running setup.py install for manifestparser 10:22:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:22:08 INFO - Running setup.py install for mozcrash 10:22:08 INFO - Running setup.py install for mozdebug 10:22:08 INFO - Running setup.py install for mozdevice 10:22:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:22:08 INFO - Running setup.py install for mozfile 10:22:09 INFO - Running setup.py install for mozhttpd 10:22:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozinfo 10:22:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozInstall 10:22:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozleak 10:22:09 INFO - Running setup.py install for mozlog 10:22:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for moznetwork 10:22:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozprocess 10:22:09 INFO - Running setup.py install for mozprofile 10:22:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozrunner 10:22:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:22:09 INFO - Running setup.py install for mozscreenshot 10:22:10 INFO - Running setup.py install for moztest 10:22:10 INFO - Running setup.py install for mozversion 10:22:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:22:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:22:10 INFO - Cleaning up... 10:22:10 INFO - Return code: 0 10:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:10 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')]} 10:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:10 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')]} 10:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:10 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:10 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 10:22:10 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 10:22:10 INFO - Using env: {'DISPLAY': ':0', 10:22:10 INFO - 'HOME': '/home/cltbld', 10:22:10 INFO - 'LANG': 'en_US.UTF-8', 10:22:10 INFO - 'LANGUAGE': 'en_US:en', 10:22:10 INFO - 'LOGNAME': 'cltbld', 10:22:10 INFO - 'MAIL': '/var/mail/cltbld', 10:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:10 INFO - 'MOZ_NO_REMOTE': '1', 10:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:10 INFO - 'NO_EM_RESTART': '1', 10:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:10 INFO - 'PWD': '/builds/slave/test', 10:22:10 INFO - 'SHELL': '/bin/bash', 10:22:10 INFO - 'SHLVL': '1', 10:22:10 INFO - 'TERM': 'linux', 10:22:10 INFO - 'TMOUT': '86400', 10:22:10 INFO - 'USER': 'cltbld', 10:22:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:10 INFO - '_': '/tools/buildbot/bin/python'} 10:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:10 INFO - Running setup.py (path:/tmp/pip-L4WikC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:10 INFO - Running setup.py (path:/tmp/pip-uPMwpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:10 INFO - Running setup.py (path:/tmp/pip-GtCr3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:10 INFO - Running setup.py (path:/tmp/pip-qEY8cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:10 INFO - Running setup.py (path:/tmp/pip-wdwnL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:10 INFO - Running setup.py (path:/tmp/pip-JFaPRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:10 INFO - Running setup.py (path:/tmp/pip-iKEscj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:10 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)) 10:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:10 INFO - Running setup.py (path:/tmp/pip-YgWlSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:11 INFO - Running setup.py (path:/tmp/pip-hdt_c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:11 INFO - Running setup.py (path:/tmp/pip-L1Ik1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:11 INFO - Running setup.py (path:/tmp/pip-dma3lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:11 INFO - Running setup.py (path:/tmp/pip-O30Lzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:11 INFO - Running setup.py (path:/tmp/pip-lBD3FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:11 INFO - Running setup.py (path:/tmp/pip-O0u3ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:11 INFO - Running setup.py (path:/tmp/pip-DPprcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:11 INFO - Running setup.py (path:/tmp/pip-snM9fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:11 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)) 10:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:11 INFO - Running setup.py (path:/tmp/pip-zIEGNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:11 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)) 10:22:11 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)) 10:22:11 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)) 10:22:11 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)) 10:22:11 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)) 10:22:11 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)) 10:22:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:11 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 10:22:11 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 10:22:11 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 10:22:11 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 10:22:12 INFO - Downloading blessings-1.6.tar.gz 10:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:22:12 INFO - Installing collected packages: blessings 10:22:12 INFO - Running setup.py install for blessings 10:22:12 INFO - Successfully installed blessings 10:22:12 INFO - Cleaning up... 10:22:13 INFO - Return code: 0 10:22:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:13 INFO - Reading from file tmpfile_stdout 10:22:13 INFO - Current package versions: 10:22:13 INFO - argparse == 1.2.1 10:22:13 INFO - blessings == 1.6 10:22:13 INFO - blobuploader == 1.2.4 10:22:13 INFO - docopt == 0.6.1 10:22:13 INFO - functools32 == 3.2.3-2 10:22:13 INFO - jsonschema == 2.5.1 10:22:13 INFO - manifestparser == 1.1 10:22:13 INFO - mozInstall == 1.12 10:22:13 INFO - mozcrash == 1.0 10:22:13 INFO - mozdebug == 0.1 10:22:13 INFO - mozdevice == 0.51 10:22:13 INFO - mozfile == 1.2 10:22:13 INFO - mozhttpd == 0.7 10:22:13 INFO - mozinfo == 0.9 10:22:13 INFO - mozleak == 0.1 10:22:13 INFO - mozlog == 3.4 10:22:13 INFO - moznetwork == 0.27 10:22:13 INFO - mozprocess == 0.25 10:22:13 INFO - mozprofile == 0.28 10:22:13 INFO - mozrunner == 6.13 10:22:13 INFO - mozscreenshot == 0.1 10:22:13 INFO - mozsystemmonitor == 0.3 10:22:13 INFO - moztest == 0.8 10:22:13 INFO - mozversion == 1.4 10:22:13 INFO - psutil == 3.1.1 10:22:13 INFO - requests == 1.2.3 10:22:13 INFO - wsgiref == 0.1.2 10:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:13 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')]} 10:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:13 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')]} 10:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:13 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:13 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 10:22:13 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 10:22:13 INFO - Using env: {'DISPLAY': ':0', 10:22:13 INFO - 'HOME': '/home/cltbld', 10:22:13 INFO - 'LANG': 'en_US.UTF-8', 10:22:13 INFO - 'LANGUAGE': 'en_US:en', 10:22:13 INFO - 'LOGNAME': 'cltbld', 10:22:13 INFO - 'MAIL': '/var/mail/cltbld', 10:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:13 INFO - 'MOZ_NO_REMOTE': '1', 10:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:13 INFO - 'NO_EM_RESTART': '1', 10:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:13 INFO - 'PWD': '/builds/slave/test', 10:22:13 INFO - 'SHELL': '/bin/bash', 10:22:13 INFO - 'SHLVL': '1', 10:22:13 INFO - 'TERM': 'linux', 10:22:13 INFO - 'TMOUT': '86400', 10:22:13 INFO - 'USER': 'cltbld', 10:22:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:13 INFO - '_': '/tools/buildbot/bin/python'} 10:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 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)) 10:22:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:22:13 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 10:22:13 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 10:22:13 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 10:22:13 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 10:22:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:22:14 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)) 10:22:14 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)) 10:22:14 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)) 10:22:14 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)) 10:22:14 INFO - Installing collected packages: marionette-driver 10:22:14 INFO - Running setup.py install for marionette-driver 10:22:14 INFO - Successfully installed marionette-driver 10:22:14 INFO - Cleaning up... 10:22:14 INFO - Return code: 0 10:22:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:22:14 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')]} 10:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:14 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')]} 10:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:14 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 0x21493b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, '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': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', '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 10:22:14 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 10:22:14 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 10:22:14 INFO - Using env: {'DISPLAY': ':0', 10:22:14 INFO - 'HOME': '/home/cltbld', 10:22:14 INFO - 'LANG': 'en_US.UTF-8', 10:22:14 INFO - 'LANGUAGE': 'en_US:en', 10:22:14 INFO - 'LOGNAME': 'cltbld', 10:22:14 INFO - 'MAIL': '/var/mail/cltbld', 10:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:14 INFO - 'MOZ_NO_REMOTE': '1', 10:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:14 INFO - 'NO_EM_RESTART': '1', 10:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:14 INFO - 'PWD': '/builds/slave/test', 10:22:14 INFO - 'SHELL': '/bin/bash', 10:22:14 INFO - 'SHLVL': '1', 10:22:14 INFO - 'TERM': 'linux', 10:22:14 INFO - 'TMOUT': '86400', 10:22:14 INFO - 'USER': 'cltbld', 10:22:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:14 INFO - '_': '/tools/buildbot/bin/python'} 10:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:22:15 INFO - Cleaning up... 10:22:15 INFO - Return code: 0 10:22:15 INFO - Running post-action listener: _resource_record_post_action 10:22:15 INFO - Running post-action listener: _start_resource_monitoring 10:22:15 INFO - Starting resource monitoring. 10:22:15 INFO - [mozharness: 2017-05-30 17:22:15.065523Z] Finished create-virtualenv step (success) 10:22:15 INFO - [mozharness: 2017-05-30 17:22:15.066043Z] Running install step. 10:22:15 INFO - Running pre-action listener: _resource_record_pre_action 10:22:15 INFO - Running main action method: install 10:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:15 INFO - Reading from file tmpfile_stdout 10:22:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:22:15 INFO - Reading from file tmpfile_stdout 10:22:15 INFO - Output received: 10:22:15 INFO - Usage: mozinstall [options] installer 10:22:15 INFO - Options: 10:22:15 INFO - -h, --help show this help message and exit 10:22:15 INFO - -d DEST, --destination=DEST 10:22:15 INFO - Directory to install application into. [default: 10:22:15 INFO - "/builds/slave/test"] 10:22:15 INFO - --app=APP Application being installed. [default: firefox] 10:22:15 INFO - mkdir: /builds/slave/test/build/application 10:22:15 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'] 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:22:31 INFO - Reading from file tmpfile_stdout 10:22:31 INFO - Output received: 10:22:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:22:31 INFO - Running post-action listener: _resource_record_post_action 10:22:31 INFO - [mozharness: 2017-05-30 17:22:31.418846Z] Finished install step (success) 10:22:31 INFO - [mozharness: 2017-05-30 17:22:31.419125Z] Running setup-mitmproxy step. 10:22:31 INFO - Running pre-action listener: _resource_record_pre_action 10:22:31 INFO - Running main action method: setup_mitmproxy 10:22:31 INFO - Skipping: mitmproxy is not required 10:22:31 INFO - Running post-action listener: _resource_record_post_action 10:22:31 INFO - [mozharness: 2017-05-30 17:22:31.420350Z] Finished setup-mitmproxy step (success) 10:22:31 INFO - [mozharness: 2017-05-30 17:22:31.420571Z] Running run-tests step. 10:22:31 INFO - Running pre-action listener: _resource_record_pre_action 10:22:31 INFO - Running main action method: run_tests 10:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:31 INFO - Python 2.7.3 10:22:31 INFO - Return code: 0 10:22:31 INFO - grabbing minidump binary from tooltool 10:22:31 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')]} 10:22:31 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 0x24c3e40>, '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 0x24c4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:31 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 10:22:31 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 10:22:31 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 10:22:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:31 INFO - Return code: 0 10:22:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:22:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:31 INFO - ENV: RUST_BACKTRACE is now 1 10:22:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:22:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:31 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/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 10:22:31 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/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 10:22:31 INFO - Using env: {'DISPLAY': ':0', 10:22:31 INFO - 'HOME': '/home/cltbld', 10:22:31 INFO - 'LANG': 'en_US.UTF-8', 10:22:31 INFO - 'LANGUAGE': 'en_US:en', 10:22:31 INFO - 'LOGNAME': 'cltbld', 10:22:31 INFO - 'MAIL': '/var/mail/cltbld', 10:22:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:31 INFO - 'MOZ_NO_REMOTE': '1', 10:22:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:31 INFO - 'NO_EM_RESTART': '1', 10:22:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:31 INFO - 'PWD': '/builds/slave/test', 10:22:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:31 INFO - 'RUST_BACKTRACE': '1', 10:22:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:22:31 INFO - 'SHELL': '/bin/bash', 10:22:31 INFO - 'SHLVL': '1', 10:22:31 INFO - 'TERM': 'linux', 10:22:31 INFO - 'TMOUT': '86400', 10:22:31 INFO - 'USER': 'cltbld', 10:22:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1496164884.134855-1389570457', 10:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:31 INFO - '_': '/tools/buildbot/bin/python'} 10:22:31 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/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 10:22:31 INFO - mozversion application_buildid: 20170530163952 10:22:31 INFO - mozversion application_changeset: 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b 10:22:31 INFO - mozversion application_display_name: Nightly 10:22:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:31 INFO - mozversion application_name: Firefox 10:22:31 INFO - mozversion application_remotingname: firefox 10:22:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:22:31 INFO - mozversion application_vendor: Mozilla 10:22:31 INFO - mozversion application_version: 55.0a1 10:22:31 INFO - mozversion platform_buildid: 20170530163952 10:22:31 INFO - mozversion platform_changeset: 39d5cc0fda5e16c49a59d29d4ca186a5534cc88b 10:22:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:22:31 INFO - mozversion platform_version: 55.0a1 10:22:31 INFO - using testdate: 1496164951 10:22:31 INFO - actual date: 1496164951 10:22:31 INFO - starting webserver on 'localhost:47898' 10:22:31 INFO - SUITE-START | Running 2 tests 10:22:31 INFO - TEST-START | dromaeo_css 10:22:31 INFO - operating with platform_type : linux_ 10:22:31 INFO - Initialising browser for dromaeo_css test... 10:22:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47898/getInfo.html -profile /tmp/tmpoH0bxg/profile 10:22:31 INFO - TEST-INFO | started process 20618 (/builds/slave/test/build/application/firefox/firefox http://localhost:47898/getInfo.html) 10:23:06 INFO - TEST-INFO | 20618: killed by SIGTERM 10:23:06 INFO - Browser initialized. 10:23:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:23:06 INFO - TEST-INFO | started process 20841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoH0bxg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:19 INFO - PID 20841 | RSS: Main: 186511360 10:23:19 INFO - PID 20841 | 10:26:23 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47898/tests/dromaeo/cssquery-ext.html) 10:26:25 INFO - PID 20841 | RSS: Main: 182534144 10:26:25 INFO - PID 20841 | 10:29:27 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-ext.html (next: http://localhost:47898/tests/dromaeo/cssquery-jquery.html) 10:29:28 INFO - PID 20841 | RSS: Main: 187396096 10:29:28 INFO - PID 20841 | 10:32:29 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47898/tests/dromaeo/cssquery-mootools.html) 10:32:30 INFO - PID 20841 | RSS: Main: 184791040 10:32:30 INFO - PID 20841 | 10:35:32 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47898/tests/dromaeo/cssquery-prototype.html) 10:35:32 INFO - PID 20841 | RSS: Main: 188649472 10:35:32 INFO - PID 20841 | 10:38:35 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47898/tests/dromaeo/cssquery-yui.html) 10:38:36 INFO - PID 20841 | RSS: Main: 187797504 10:38:36 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | Cycle 1(1): loaded http://localhost:47898/tests/dromaeo/cssquery-yui.html (next: http://localhost:47898/tests/dromaeo/cssquery-dojo.html) 10:41:38 INFO - PID 20841 | RSS: Main: 185139200 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | __start_tp_report 10:41:38 INFO - PID 20841 | _x_x_mozilla_page_load 10:41:38 INFO - PID 20841 | _x_x_mozilla_page_load_details 10:41:38 INFO - PID 20841 | |i|pagename|runs| 10:41:38 INFO - PID 20841 | |0;dojo.html;2699.770519505842;2722.482728281625;2726.7273272672737;2754.944901101978;2763.502569537484;5131.153359695655;5190.221466779984;5211.5049070338355;5226.895462090756;5254.632175747699;5153.896922061566;5180.999999999991;5195.662281951671;5305.363356397238;5311.49540793624;4642.117997580466;4668.603168730662;4673.299005149238;4698.08387364464;4736.97631511842;4639.234526303156;4657.5575320344515;4763.2378819388905;4764.047190561884;4787.784549695272;4624.653151013687;4664.930026049612;4680.64895132863;4698.483166851644;4754.976225118887;4656.976715116437;4686.929696054562;4717.080169366975;4717.103750287434;4722.268048452495;4670.673052886299;4677.462091859412;4678.976605116986;4694.413198350207;4740.502247264057;5191.143461328877;5212.087884620214;5223.294855194538;5260.316158899357;5263.842084737464;5510.338759348863;5557.3886872444;5572.972135139339;5590.161475778625;5654.321481422215;5645.096784514458;5687.40282270364;5700.201971723921;5700.7149642518125;5702.486776190163;5245.265662807134;5303.549198318186;5306.151015837448;5306.708131052752;5354.768403267192;5682.516986056232;5761.8559536011935;5764.279465066867;5766.711664416763;5820.156077368758;5389.595780316414;5457.126859702428;5472.808451704172;5497.972510137423;5548.472895074961;5666.858328541819;5679.8864022720145;5683.8010669626365;5688.63023903445;5689.715514224272;5489.176623506426;5638.323401191883;5639.689817060101;5645.040343141676;5654.575906807006;5537.667739935536;5582.665040097607;5643.238162848045;5667.121596152603;5694.60137790359;4737.6683632146105;4743.075100355467;4750.049990002013;4782.115308667908;4788.329633851264;4048;4054.7769872656695;4066.268071747055;4071;4115.97942010288;4558.954410455853;4599.816007359735;4609.492955774862;4658.324542941255;4763.071201115749;5643.294588176478;5644.717764111778;5660.8867822643315;5663.943360566424;5727.3699893011735;4707.364505791743;4733.83431579893;4743.1225223333795;4743.383360163157;4757.119932812371;4937.629677774181;5026.748662566857;5044.243363495505;5049.924251136236;5071.949280507221;5180.792768289377;5214.661047032083;5248.9475105249985;5271.815486457956;5281.973590132025;5528.336599608073;5634.971825141012;5637.154426836008;5672.4894759471845;5673.489385955284;5169.638125331341;5173.275741396133;5192.3769147702515;5195.636305458733;5309.920351194813;5504.889902201853;5619.971900140473;5624.634398764068;5649.858753531194;5663.32040155184;5489.204065410413;5562.916556251578;5583.860403489945;5719.3136823581435;5729.312482502127;5451.64564303319;5452.727363631723;5525.419830917695;5526.530244929065;5538.556915446674;5426.891462170814;5436.809711660073;5449.836504904859;5474.972625136849;5553.389127195925;5355.357357117171;5440.455954404528;5459.563234941115;5459.617826752089;5503.614746967834;5447.0467668157125;5483.616146869681;5523.116301391758;5526.889462210653;5561.972190139023;5358.6248962572245;5385.192221166856;5404.351477822686;5404.891902162013;5447.373552041566 10:41:38 INFO - PID 20841 | |1;ext.html;629.2166253014994;692.3526502719957;698.3889097040088;1199.6760874563863;1233.4819375862137;35623.821880890595;36541.63458365419;36610.633893661055;36619;36665.81667091661;35515.644843551556;35805.13558915287;35813.64186358135;35964.82017589915;35969.1007724807;6478.2226132864125;6587.538872278942;6664.500162487833;6859.691313890887;6870.45036397087;6817.590944543318;6939.618320992344;6942.895856562156;6958.930410695879;6959.582425054513;6919.723211071551;6983.9650801746175;6984.196817366017;6986.231514533397;6989.615571143585;6912.930870691279;6925.619090949996;6932.445404367639;6957.5129740918155;6961.582305061713;6672.633005184713;6693.129893113913;6717.56335838169;6718.454755406284;6725.05849181115;33536.664633353845;33554.83222583871;33642;33831.323373532636;33906;3028.424599326121;3051.099925521954;3057.7706671999467;3060.617422822147;3073.9538906916414;25308;25373.365665858317;25449.363765905815;25507.489850202892;25544.36139096519;3085.706857848523;3098.0860646109227;3118.8128712277335;3133.8276394798277;3153.8173185055603;125956;128749.71250287471;148611;149399;149631.2518437401;40548;41018.38472422916;41210.79394603068;41230.79384603058;41389.37915931264;41995;42355;42472.78763606162;42600.57399425966;44955.70620113187;13477.865221347856;13533.796993045113;13541.661458463617;13570.59288221355;13638;10870.510827012804;10904.727381815359;10907.945460272647;10924.508397122148;10931.289466184673;13419.463221471227;13457.461701531829;13470.191788492722;13502.797458038138;13663.863361366259;5238.188080847474;5304.071787437183;5311.150215965427;5342.652727572696;5350.224217488442;831.7546323834483;856.546030603781;898.9415687980261;908.3966798600476;912.4023764434173;21592.4601884951;22239.888800555895;22387;22639.43401414945;22667.319980400614;978.6819283732815;980.3382716666222;990.4948476277151;1005.6932635546228;1008.5864795433837;11209;11833.763324733458;11843;11848.229865058744;12009.399530023464;157635;160120;161002.1949890243;161104;174929;48507.272390914164;49410.258846117336;49437.25844112341;49480.25779613309;49481;1223.5411720604773;1273.7134144817342;1287.9098463107493;1288.3043156695467;1288.8195652608642;25707.87146064258;26035;26665.8666706673;27032.72967270381;27036.864815675795;32060.358792824478;37504;39369.63782173079;39503.407448887716;39738.2052358957;168838;168851;169261;170073.34669939635;170394;30221.395572088873;30434.239144021576;30550.694493055675;30552.84723576368;30836.537451938686;37117.25765484621;37452.06369840776;38275.42586861143;38457;38674;28182.577261341507;28346.574801377585;29132.126036218946;29759.40481190321;30450.84774576113;28094.71905281003;28187.43625127527;28284.71715282821;28714.85642571774;29672.851635741685;33020;33064.33871322608;33214;33229.66770332266;33245.335093297515;27023.189304320902;27680.307992300353;27864;29100.854495727384;29286;21619;22717.2048978285;22742.317730468112;22835.429114272276;22997.770022299563 10:41:38 INFO - PID 20841 | |2;jquery.html;404.9838006479741;405.2401746724891;425.0839441004635;432.89177705573604;444.8398576512457;18377.724334135;18854.151563179672;18857;18885.244590216393;20754.688679669816;20215.696764548542;20785.584288314225;20800.16799328025;20811.479713007182;20825.37523874286;5454.672719636835;5620.775168993236;5622.634528755638;5628.915566266509;5634;5310.15037593985;5565.359983601877;5575.553955683536;5727.627704199213;5785.161151633031;5490.478404551562;5493.670379777206;5535.501804837564;5548.6393384430085;5554.805581804638;5514.338279406456;5537.058700021006;5555.083411237141;5556.333240011225;5563.165525171236;5008.774605142778;5023.070731914571;5029.119904016819;5034.194528875399;5037;23406.18078367249;23976;24372;24428.63357049646;24458.26625201247;1612.5887898585902;1651.983480165195;1652.5207689769952;1652.644681393506;1653.7188677924782;15357.46248881295;15788.763168552481;15853.762193567105;15867.206639667971;15879.36482540697;2064.5870825834895;2104.2214380679247;2123.5646692428168;2132.893355332227;2169.39257008038;94122.52938735331;95194;96194.51902740581;96234;96389.51805240999;10773.784524309627;11194.384308862927;11254.49354779037;11373.658790236306;11546.59586914454;16167;16199.514014579581;16213.918930405272;16238.350465981228;16309.184540772914;8227.506349619041;8334.66661333552;8349.081601023883;8365.205305495969;8451.070382257947;6658.101156343929;7202.855942881113;7237.131544214728;7239.638018099074;7878.803029924297;7047;7498.938216703703;7550.697972081055;7553;7586.62066896653;2012.104613447002;2021.919123235054;2058.1561559760426;2062.9381118566466;2160.6975023496725;824.575343697996;862.741177646716;878.5519385113511;891.572045418203;897.3270047464401;17426.564335891704;17708.29166833338;17785.597185013386;18038.188281527364;18337.99141047255;865.1175800683268;889.213046453893;892.848215803315;895.4045559702855;914.5975770660888;9535.809283814286;9577.329586928987;9687.806243875224;9925.2059835213;9981.45102019396;353286;354520;356324;359284;364279;83920.16079839246;84567.57716211502;85223.5738821302;85657;85850;1031.8813336466403;1060.1783617696192;1071.2501249125644;1072.8819829818713;1080.448971024783;15085.773713394088;15237.847621523642;15568.209655889717;15690.097331993162;16165.191740412698;39872;40609.79695101506;40863.59136408598;41274.79362603168;41499.1700166001;50256.24615630695;50327.74836125796;50448.24327635162;57301;60687.39312606817;9480.336376453582;10070.395776253448;10103.595856165672;10106.292559520763;10116.29185956976;16464.753028704818;16488.83511164921;16526.42157524529;16615;16718.164091795607;13868.722625547634;13931.651708707363;13938.72122557523;13957.860421396063;14317.284135792961;11735.76528469443;12745.745085098431;12898;13067.51717173734;13460.855827254793;14354.928225358806;14459.493917712829;14470.565883023526;14483.348249328596;14519;9952.154066904393;10079.092881640687;10125.392476451436;10127.848082278919;10133.493325333851;13804;13924.443022278996;13928.60713928599;14047.157170569799;14053 10:41:38 INFO - PID 20841 | |3;mootools.html;1231.4704676988895;1269.4224128021751;1304.0350140895735;1308.6859153803084;1313.395837914559;9923.106920377164;10407.583696652135;10420.739481512966;11135.888641113586;11542.769144617123;11030.779384412306;11244.4939977701;11247.718807029829;11259.831102533448;11264.605738799144;2115.830733541317;2152.2251989283845;2155.5581105873257;2162.0270878104916;2163.642998905179;2035.226613886721;2051.897405129745;2073.616380969518;2075.408508575056;2093.6440805063176;2093.1522733292963;2121.6499277619173;2122.1405330841035;2129.4889226585665;2143.303426386423;1990.7909669484714;1998.4604156877635;2001.4195883193856;2005.2380095563738;2009.9296524621568;1833.3125078095713;1904.6000339928632;2069.0585783468487;2082.739657542807;2093.8534302598823;10858.402787846666;10934.726631834188;10972.122230221563;10989.560417583287;11006.779864402668;5437.564994800407;5683;5684.403137670526;5685.260916080924;5687.317521897357;3299.191698033997;3396.677315655009;3441.328940856534;3477.8434970426138;3484.686378225972;1025.2054657640388;1030.8556802047644;1056.0442799266675;1056.1603525197486;1057.804306203347;16320.673586528203;16378.344866205338;16429.83570164295;16475.83524164767;16561.337546498125;4713.457952335457;4773.1408346497965;4909.656324057353;4957.157283261854;4962.305277261186;11886.940565297118;11894.167408281337;11900.047996160287;11914.52341906314;11937.343446110373;5467.890642187134;5624.29696287964;5640.097584386561;5641.323041234996;5643.717814109278;5119.078565858107;5122.129238029544;5156.5616922562;5187.351581052369;5320;3927.136030073379;4013.478247827822;4058.188362327546;4089.3048181809163;4119.237940980928;1097.0801098078364;1107.379867274329;1111.8054340490382;1118.2675347647305;1123.1969142063465;666.2404858461358;692.6986760759086;694.3230350408312;710.8791505444087;720.0854914258862;5550.500454959073;6201.0388389799655;6207.534434917399;6279.686015699197;6417.593402474072;833.9207775261341;857.6397912876607;867.418829384314;879.1560102301734;882.7395918204016;3529.94705079424;3642.2897534980953;3650.4889315495852;3753.83107760146;3779.055236190952;13349.132306400053;13573.660658483617;13573.86426135726;13660.453581856813;13719.1082579632;12407.565735199225;12602.936985315198;12605.495780168874;12626.242425454502;12647.177933434297;7421.851562968711;7509.62451877404;7527.172011078777;7528.5859277739155;7600.923990760021;5681.630694004876;5973.880522389615;6044.546659000504;6050.2437195350585;6249.375062493714;12479.625611231677;12842.101052926206;12893.806592901301;12897.29064901402;13078.28069456189;13389.598312050653;13391.330433478091;13557.864421356055;13612.727745445234;13645.522406715718;8879.289656827568;8938.195562399414;8973.82052358936;9027.09729027092;9041.728748137566;10141.898581014391;10254.333468324536;10271.435071071162;10312.329698569569;10320.948395257976;8220.342372610057;8354.749357519284;8463.915360846559;8567.957160214408;8568.700095496628;8194.262516373556;8297.294729948022;8341.95829020851;8362.87455688153;8529.061803201766;7142.5714457132735;7314;7319.74380896666;7326.890096648448;7327.303906128909;4270.338097594878;4960.925586116284;5033.094043072282;5049.5960323174795;5061.392632884077;4827.565519103297;4864.61083113343;4957.132501812096;5001.099802035523;5003.049420610072 10:41:38 INFO - PID 20841 | |4;prototype.html;356.61841829242707;365.4901412529521;369.11964963561894;370.7423340778159;371.4150213413872;5512.944870551293;5618.550515958724;5660.160562718878;5667.716614169291;5696.914546281809;5397.190421436787;5450.618456708032;5460.781568737246;5466.972665136679;5481.561475081994;4153.335466325389;4157.937630935531;4158.168366326731;4159.604837540429;4182.832686692529;4155.065110350177;4171.895702607444;4176.290030694774;4179.916401671965;4183.916321673565;4119.649829764474;4131.194417088669;4135.296999510076;4136.97931510342;4149.647279981205;4136.007358234017;4147.875563733093;4155.854545090938;4156.9792151039355;4158.126793373395;3605.7295702822394;3610.7472476926364;3615.891523254307;3621.5110960020324;3634.9273014539563;5341.6527925685095;5345;5359.6319000015255;5365.517103460707;5395.325584301962;4821.879453013703;4839.491853355417;4847.781849816767;4856.732879691615;4863.489333619989;5782.537397008271;5799.246098007232;5802.622829516068;5805.268706004593;5819.0689489681445;4019.155977244782;4023.637872591481;4030.5767894371256;4032.7095329494573;4049.817758200888;5849.883002339972;6057.273127224761;6161.487951867437;6184.546631541584;6194.915889719281;4032.5967403259438;4076.8573099941955;4085.816138273785;4096.774677392712;4110.958890411118;4162.105147393265;4178.644815190682;4179.623833854967;4188.120494696087;4194.385161712763;4803.135435621552;4803.687760295569;4809.807607695653;4812.639052071108;4993.800247990112;5889.204957330706;5927.644341339534;5936.011436168846;5946.524278057745;5947.49446297061;1562.2579274844586;1569.3722510995465;1578.5974576482924;1579.336678594993;1580.6880289359804;1088.0262165362115;1102.6030628973563;1130.8021096308278;1135.8296255561731;1142.7371704507843;5030.8239211627415;5033.974830125826;5059.392872855207;5061.31672224245;5091.516305950929;6011.909821352683;6050.878982420415;6073.6659483727935;6088;6108.56448734547;4960.23116416956;5007.89826238227;5010.348654674869;5018.422881368616;5030.673006254582;3190.3938251732097;3232.9676703233135;3233.1917020744813;3240.659730728287;3240.935181296361;5570.303712035996;5577.107662773937;5593.272874526286;5595.160725891149;5630.577706672016;6186.4741496972365;6217.906731398942;6228;6231.283402408781;6235.594686345373;5580.99084329641;5616.522595579339;5619.999999999918;5625.38120806711;5638.379778224474;6077.817665470043;6093.908591371044;6097.725602347994;6099.4510494053975;6126.540509461719;5940.46535811779;5982.790602328898;5987.64074155552;6001;6018.9398106020135;5277.329563336398;5377.838664840061;5530.170474428707;5600.7199640017025;5626.2967129108865;4457.531959144243;4491.932621010622;4503.851517863055;4506.797194126207;4509.819607215806;6073.696315184135;6090.908636370546;6093.116498107661;6095.512359011357;6126.356732543197;5737.569682273763;5886.264216972879;5897.498712609477;5899.823005309848;5904.439078287556;5854.736536855767;5864.296284445893;5883.61756485827;5896.262967129109;5909.52723782105;5797.797077102281;5802.47777700009;5827.329857066492;5839.766409343579;5841.4450627190345;5952.107183922446;5958.910616340671;5972.193753843176;5987.730552125252;5993.550483713651;5771.4805667488445;5780.884382312246;5801.82594522165;5815.302163740378;5839.445252700986 10:41:38 INFO - PID 20841 | |5;yui.html;719.9316064973825;735.0444422251072;745.6346390268768;753.8040109571513;767.3669222891116;13916.791248131274;14915.627109322273;14926.626834329134;15315.387384504635;17308.567285817862;14666.926665366685;14667.779983300232;14686.118832870035;14706.852931470683;14717.190554519497;910.9772255693628;934.6635211323918;940.4827344960279;940.7459985803829;941.3739862991102;845.5391811462737;905.6965916417975;914.89021317442;934.1872570863359;936.4287784451479;974.0113784508729;978.3054031637546;978.3738407419257;978.8433850583908;979.1725991537176;963.3834346018554;971.2715463402449;973.737090985437;977.2279898879876;979.1530326267763;715.1275443958363;715.3490323805364;716.7634680555404;718.3534818663193;718.5293632670557;14966.47617333399;15263.08421494714;15376.615584610363;15453.918225724205;15459.917805753601;16463.176841157896;17013.91493042539;17047;17087.060211688353;17117.229724662295;12798.552050678181;13164.934175329063;13305.334733263298;13336.933315333457;13338.93330533341;3029.9394012119856;3038.14931819091;3057.755379569629;3072.2319420144963;3075.6616772155044;88412;89120.55439722825;89578.10421895828;90119;90944.99999999935;12911.22532648044;13241.867581324064;13266.204027758366;13411.530596429078;13502.594922152352;23943.16198933029;23967.52064958691;24663.50672986566;24732.38169045752;24930.12744553968;6374.681265936684;6446.484281257488;6454.612723236621;6475.546711730133;6507.089007538948;2983.597214376075;3027.076741593835;3041.7718671099756;3047.08587423772;3056.190109620952;4155;4405.537418571068;4414.168120230132;4421.579949904818;4457.665675074382;768.5388766739911;788.7751990682627;799.7240951871595;800.3077338102499;802.8153524689354;591.1428428778289;604.1481511069371;609.0894113300556;621.9906701399483;632.9588576742497;9607.327487075838;9907.851382229272;9984;10238.897611023944;11332.546698132148;609.2719200555293;610.6397225636896;621.7854840080165;621.860081481663;633.8193614819754;4826.61387089032;4996.7001979881325;5003.124453220672;5042.218456139304;5143.254228136974;75568.62215688996;76297;77371.61314193394;78761.60619196868;85056.57471712602;66022;66029;67676;68960;69887;58559;60104.39895601075;60575.394246056974;63246.36753632497;63708.68145659242;10489.790204196026;11378.203525753117;11509.769804603693;11647.359395233005;11659.125565582784;28147.296317591405;28497;30793.538096928114;31136;32309.838450807594;60728;64311;64338.35661643324;66168.33831661814;67709.6614516944;15571.922140389226;15828.44600438979;16074.276657550205;16425.83574164243;16772.909760865503;17788.3774067907;17789.46631601054;17974.91012544929;18194.09029548544;18299;13412.12821166621;14214.076085054437;14369.353379098175;14509.854901451272;15277.847221527643;15512.146831923901;15555.377784888478;15879.364825407316;15942.760858586898;16341.67316653684;14245.28773561297;14695;14731.852681473049;14842.257887105385;14932.552023439313;12191.963683087037;12307.507699691912;12354.629361119181;12431.813522796985;12694.619161425171;12764.425600847799;13198;13481.662958426117;13499.042638817513;13602.795958060438 10:41:38 INFO - PID 20841 | __end_tp_report 10:41:38 INFO - PID 20841 | __start_cc_report 10:41:38 INFO - PID 20841 | _x_x_mozilla_cycle_collect,389 10:41:38 INFO - PID 20841 | __end_cc_report 10:41:38 INFO - PID 20841 | __startTimestamp1496166098725__endTimestamp 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | ------- Summary: start ------- 10:41:38 INFO - PID 20841 | Number of tests: 6 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#0] dojo.html Cycles:165 Average:5155.34 Median:5309.92 stddev:601.04 (11.3%) stddev-sans-first:571.18 10:41:38 INFO - PID 20841 | Values: 2699.8 2722.5 2726.7 2754.9 2763.5 5131.2 5190.2 5211.5 5226.9 5254.6 5153.9 5181.0 5195.7 5305.4 5311.5 4642.1 4668.6 4673.3 4698.1 4737.0 4639.2 4657.6 4763.2 4764.0 4787.8 4624.7 4664.9 4680.6 4698.5 4755.0 4657.0 4686.9 4717.1 4717.1 4722.3 4670.7 4677.5 4679.0 4694.4 4740.5 5191.1 5212.1 5223.3 5260.3 5263.8 5510.3 5557.4 5573.0 5590.2 5654.3 5645.1 5687.4 5700.2 5700.7 5702.5 5245.3 5303.5 5306.2 5306.7 5354.8 5682.5 5761.9 5764.3 5766.7 5820.2 5389.6 5457.1 5472.8 5498.0 5548.5 5666.9 5679.9 5683.8 5688.6 5689.7 5489.2 5638.3 5639.7 5645.0 5654.6 5537.7 5582.7 5643.2 5667.1 5694.6 4737.7 4743.1 4750.0 4782.1 4788.3 4048.0 4054.8 4066.3 4071.0 4116.0 4559.0 4599.8 4609.5 4658.3 4763.1 5643.3 5644.7 5660.9 5663.9 5727.4 4707.4 4733.8 4743.1 4743.4 4757.1 4937.6 5026.7 5044.2 5049.9 5071.9 5180.8 5214.7 5248.9 5271.8 5282.0 5528.3 5635.0 5637.2 5672.5 5673.5 5169.6 5173.3 5192.4 5195.6 5309.9 5504.9 5620.0 5624.6 5649.9 5663.3 5489.2 5562.9 5583.9 5719.3 5729.3 5451.6 5452.7 5525.4 5526.5 5538.6 5426.9 5436.8 5449.8 5475.0 5553.4 5355.4 5440.5 5459.6 5459.6 5503.6 5447.0 5483.6 5523.1 5526.9 5562.0 5358.6 5385.2 5404.4 5404.9 5447.4 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#1] ext.html Cycles:180 Average:31488.67 Median:3108.45 stddev:40869.95 (1314.8%) stddev-sans-first:40918.91 10:41:38 INFO - PID 20841 | Values: 629.2 692.4 698.4 1199.7 1233.5 35623.8 36541.6 36610.6 36619.0 36665.8 35515.6 35805.1 35813.6 35964.8 35969.1 6478.2 6587.5 6664.5 6859.7 6870.5 6817.6 6939.6 6942.9 6958.9 6959.6 6919.7 6984.0 6984.2 6986.2 6989.6 6912.9 6925.6 6932.4 6957.5 6961.6 6672.6 6693.1 6717.6 6718.5 6725.1 33536.7 33554.8 33642.0 33831.3 33906.0 3028.4 3051.1 3057.8 3060.6 3074.0 25308.0 25373.4 25449.4 25507.5 25544.4 3085.7 3098.1 3118.8 3133.8 3153.8 125956.0 128749.7 148611.0 149399.0 149631.3 40548.0 41018.4 41210.8 41230.8 41389.4 41995.0 42355.0 42472.8 42600.6 44955.7 13477.9 13533.8 13541.7 13570.6 13638.0 10870.5 10904.7 10907.9 10924.5 10931.3 13419.5 13457.5 13470.2 13502.8 13663.9 5238.2 5304.1 5311.2 5342.7 5350.2 831.8 856.5 898.9 908.4 912.4 21592.5 22239.9 22387.0 22639.4 22667.3 978.7 980.3 990.5 1005.7 1008.6 11209.0 11833.8 11843.0 11848.2 12009.4 157635.0 160120.0 161002.2 161104.0 174929.0 48507.3 49410.3 49437.3 49480.3 49481.0 1223.5 1273.7 1287.9 1288.3 1288.8 25707.9 26035.0 26665.9 27032.7 27036.9 32060.4 37504.0 39369.6 39503.4 39738.2 168838.0 168851.0 169261.0 170073.3 170394.0 30221.4 30434.2 30550.7 30552.8 30836.5 37117.3 37452.1 38275.4 38457.0 38674.0 28182.6 28346.6 29132.1 29759.4 30450.8 28094.7 28187.4 28284.7 28714.9 29672.9 33020.0 33064.3 33214.0 33229.7 33245.3 27023.2 27680.3 27864.0 29100.9 29286.0 21619.0 22717.2 22742.3 22835.4 22997.8 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#2] jquery.html Cycles:180 Average:25954.44 Median:24400.32 stddev:59983.44 (245.8%) stddev-sans-first:60121.03 10:41:38 INFO - PID 20841 | Values: 405.0 405.2 425.1 432.9 444.8 18377.7 18854.2 18857.0 18885.2 20754.7 20215.7 20785.6 20800.2 20811.5 20825.4 5454.7 5620.8 5622.6 5628.9 5634.0 5310.2 5565.4 5575.6 5727.6 5785.2 5490.5 5493.7 5535.5 5548.6 5554.8 5514.3 5537.1 5555.1 5556.3 5563.2 5008.8 5023.1 5029.1 5034.2 5037.0 23406.2 23976.0 24372.0 24428.6 24458.3 1612.6 1652.0 1652.5 1652.6 1653.7 15357.5 15788.8 15853.8 15867.2 15879.4 2064.6 2104.2 2123.6 2132.9 2169.4 94122.5 95194.0 96194.5 96234.0 96389.5 10773.8 11194.4 11254.5 11373.7 11546.6 16167.0 16199.5 16213.9 16238.4 16309.2 8227.5 8334.7 8349.1 8365.2 8451.1 6658.1 7202.9 7237.1 7239.6 7878.8 7047.0 7498.9 7550.7 7553.0 7586.6 2012.1 2021.9 2058.2 2062.9 2160.7 824.6 862.7 878.6 891.6 897.3 17426.6 17708.3 17785.6 18038.2 18338.0 865.1 889.2 892.8 895.4 914.6 9535.8 9577.3 9687.8 9925.2 9981.5 353286.0 354520.0 356324.0 359284.0 364279.0 83920.2 84567.6 85223.6 85657.0 85850.0 1031.9 1060.2 1071.3 1072.9 1080.4 15085.8 15237.8 15568.2 15690.1 16165.2 39872.0 40609.8 40863.6 41274.8 41499.2 50256.2 50327.7 50448.2 57301.0 60687.4 9480.3 10070.4 10103.6 10106.3 10116.3 16464.8 16488.8 16526.4 16615.0 16718.2 13868.7 13931.7 13938.7 13957.9 14317.3 11735.8 12745.7 12898.0 13067.5 13460.9 14354.9 14459.5 14470.6 14483.3 14519.0 9952.2 10079.1 10125.4 10127.8 10133.5 13804.0 13924.4 13928.6 14047.2 14053.0 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#3] mootools.html Cycles:180 Average:6505.72 Median:3419.00 stddev:4353.00 (127.3%) stddev-sans-first:4347.17 10:41:38 INFO - PID 20841 | Values: 1231.5 1269.4 1304.0 1308.7 1313.4 9923.1 10407.6 10420.7 11135.9 11542.8 11030.8 11244.5 11247.7 11259.8 11264.6 2115.8 2152.2 2155.6 2162.0 2163.6 2035.2 2051.9 2073.6 2075.4 2093.6 2093.2 2121.6 2122.1 2129.5 2143.3 1990.8 1998.5 2001.4 2005.2 2009.9 1833.3 1904.6 2069.1 2082.7 2093.9 10858.4 10934.7 10972.1 10989.6 11006.8 5437.6 5683.0 5684.4 5685.3 5687.3 3299.2 3396.7 3441.3 3477.8 3484.7 1025.2 1030.9 1056.0 1056.2 1057.8 16320.7 16378.3 16429.8 16475.8 16561.3 4713.5 4773.1 4909.7 4957.2 4962.3 11886.9 11894.2 11900.0 11914.5 11937.3 5467.9 5624.3 5640.1 5641.3 5643.7 5119.1 5122.1 5156.6 5187.4 5320.0 3927.1 4013.5 4058.2 4089.3 4119.2 1097.1 1107.4 1111.8 1118.3 1123.2 666.2 692.7 694.3 710.9 720.1 5550.5 6201.0 6207.5 6279.7 6417.6 833.9 857.6 867.4 879.2 882.7 3529.9 3642.3 3650.5 3753.8 3779.1 13349.1 13573.7 13573.9 13660.5 13719.1 12407.6 12602.9 12605.5 12626.2 12647.2 7421.9 7509.6 7527.2 7528.6 7600.9 5681.6 5973.9 6044.5 6050.2 6249.4 12479.6 12842.1 12893.8 12897.3 13078.3 13389.6 13391.3 13557.9 13612.7 13645.5 8879.3 8938.2 8973.8 9027.1 9041.7 10141.9 10254.3 10271.4 10312.3 10320.9 8220.3 8354.7 8463.9 8568.0 8568.7 8194.3 8297.3 8342.0 8362.9 8529.1 7142.6 7314.0 7319.7 7326.9 7327.3 4270.3 4960.9 5033.1 5049.6 5061.4 4827.6 4864.6 4957.1 5001.1 5003.0 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#4] prototype.html Cycles:180 Average:4828.69 Median:5386.58 stddev:1419.34 (26.3%) stddev-sans-first:1383.06 10:41:38 INFO - PID 20841 | Values: 356.6 365.5 369.1 370.7 371.4 5512.9 5618.6 5660.2 5667.7 5696.9 5397.2 5450.6 5460.8 5467.0 5481.6 4153.3 4157.9 4158.2 4159.6 4182.8 4155.1 4171.9 4176.3 4179.9 4183.9 4119.6 4131.2 4135.3 4137.0 4149.6 4136.0 4147.9 4155.9 4157.0 4158.1 3605.7 3610.7 3615.9 3621.5 3634.9 5341.7 5345.0 5359.6 5365.5 5395.3 4821.9 4839.5 4847.8 4856.7 4863.5 5782.5 5799.2 5802.6 5805.3 5819.1 4019.2 4023.6 4030.6 4032.7 4049.8 5849.9 6057.3 6161.5 6184.5 6194.9 4032.6 4076.9 4085.8 4096.8 4111.0 4162.1 4178.6 4179.6 4188.1 4194.4 4803.1 4803.7 4809.8 4812.6 4993.8 5889.2 5927.6 5936.0 5946.5 5947.5 1562.3 1569.4 1578.6 1579.3 1580.7 1088.0 1102.6 1130.8 1135.8 1142.7 5030.8 5034.0 5059.4 5061.3 5091.5 6011.9 6050.9 6073.7 6088.0 6108.6 4960.2 5007.9 5010.3 5018.4 5030.7 3190.4 3233.0 3233.2 3240.7 3240.9 5570.3 5577.1 5593.3 5595.2 5630.6 6186.5 6217.9 6228.0 6231.3 6235.6 5581.0 5616.5 5620.0 5625.4 5638.4 6077.8 6093.9 6097.7 6099.5 6126.5 5940.5 5982.8 5987.6 6001.0 6018.9 5277.3 5377.8 5530.2 5600.7 5626.3 4457.5 4491.9 4503.9 4506.8 4509.8 6073.7 6090.9 6093.1 6095.5 6126.4 5737.6 5886.3 5897.5 5899.8 5904.4 5854.7 5864.3 5883.6 5896.3 5909.5 5797.8 5802.5 5827.3 5839.8 5841.4 5952.1 5958.9 5972.2 5987.7 5993.6 5771.5 5780.9 5801.8 5815.3 5839.4 10:41:38 INFO - PID 20841 | 10:41:38 INFO - PID 20841 | [#5] yui.html Cycles:180 Average:18350.69 Median:31722.92 stddev:23276.54 (73.4%) stddev-sans-first:23304.19 10:41:38 INFO - PID 20841 | Values: 719.9 735.0 745.6 753.8 767.4 13916.8 14915.6 14926.6 15315.4 17308.6 14666.9 14667.8 14686.1 14706.9 14717.2 911.0 934.7 940.5 940.7 941.4 845.5 905.7 914.9 934.2 936.4 974.0 978.3 978.4 978.8 979.2 963.4 971.3 973.7 977.2 979.2 715.1 715.3 716.8 718.4 718.5 14966.5 15263.1 15376.6 15453.9 15459.9 16463.2 17013.9 17047.0 17087.1 17117.2 12798.6 13164.9 13305.3 13336.9 13338.9 3029.9 3038.1 3057.8 3072.2 3075.7 88412.0 89120.6 89578.1 90119.0 90945.0 12911.2 13241.9 13266.2 13411.5 13502.6 23943.2 23967.5 24663.5 24732.4 24930.1 6374.7 6446.5 6454.6 6475.5 6507.1 2983.6 3027.1 3041.8 3047.1 3056.2 4155.0 4405.5 4414.2 4421.6 4457.7 768.5 788.8 799.7 800.3 802.8 591.1 604.1 609.1 622.0 633.0 9607.3 9907.9 9984.0 10238.9 11332.5 609.3 610.6 621.8 621.9 633.8 4826.6 4996.7 5003.1 5042.2 5143.3 75568.6 76297.0 77371.6 78761.6 85056.6 66022.0 66029.0 67676.0 68960.0 69887.0 58559.0 60104.4 60575.4 63246.4 63708.7 10489.8 11378.2 11509.8 11647.4 11659.1 28147.3 28497.0 30793.5 31136.0 32309.8 60728.0 64311.0 64338.4 66168.3 67709.7 15571.9 15828.4 16074.3 16425.8 16772.9 17788.4 17789.5 17974.9 18194.1 18299.0 13412.1 14214.1 14369.4 14509.9 15277.8 15512.1 15555.4 15879.4 15942.8 16341.7 14245.3 14695.0 14731.9 14842.3 14932.6 12192.0 12307.5 12354.6 12431.8 12694.6 12764.4 13198.0 13481.7 13499.0 13602.8 10:41:38 INFO - PID 20841 | -------- Summary: end -------- 10:41:38 INFO - PID 20841 | 10:41:39 INFO - TEST-INFO | 20841: exit 0 10:41:39 INFO - TEST-OK | dromaeo_css | took 1147900ms 10:41:39 INFO - TEST-START | kraken 10:41:39 INFO - operating with platform_type : linux_ 10:41:39 INFO - Initialising browser for kraken test... 10:41:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47898/getInfo.html -profile /tmp/tmpiwp8He/profile 10:41:39 INFO - TEST-INFO | started process 21263 (/builds/slave/test/build/application/firefox/firefox http://localhost:47898/getInfo.html) 10:42:14 INFO - TEST-INFO | 21263: killed by SIGTERM 10:42:14 INFO - Browser initialized. 10:42:14 INFO - Running cycle 1/1 for kraken test... 10:42:14 INFO - TEST-INFO | started process 21484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwp8He/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:42:27 INFO - PID 21484 | RSS: Main: 186138624 10:42:27 INFO - PID 21484 | 10:42:29 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47898/tests/kraken/driver.html?testName=audio-beat-detection) 10:42:30 INFO - PID 21484 | RSS: Main: 189251584 10:42:30 INFO - PID 21484 | 10:42:33 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47898/tests/kraken/driver.html?testName=audio-dft) 10:42:33 INFO - PID 21484 | RSS: Main: 188608512 10:42:33 INFO - PID 21484 | 10:42:36 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47898/tests/kraken/driver.html?testName=audio-fft) 10:42:37 INFO - PID 21484 | RSS: Main: 185114624 10:42:37 INFO - PID 21484 | 10:42:39 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47898/tests/kraken/driver.html?testName=audio-oscillator) 10:42:40 INFO - PID 21484 | RSS: Main: 185769984 10:42:40 INFO - PID 21484 | 10:42:42 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:42:43 INFO - PID 21484 | RSS: Main: 185851904 10:42:43 INFO - PID 21484 | 10:42:46 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47898/tests/kraken/driver.html?testName=imaging-darkroom) 10:42:46 INFO - PID 21484 | RSS: Main: 189845504 10:42:46 INFO - PID 21484 | 10:42:50 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47898/tests/kraken/driver.html?testName=imaging-desaturate) 10:42:51 INFO - PID 21484 | RSS: Main: 185729024 10:42:51 INFO - PID 21484 | 10:42:53 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47898/tests/kraken/driver.html?testName=json-parse-financial) 10:42:54 INFO - PID 21484 | RSS: Main: 186638336 10:42:54 INFO - PID 21484 | 10:42:56 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:42:56 INFO - PID 21484 | RSS: Main: 186675200 10:42:56 INFO - PID 21484 | 10:42:58 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:42:59 INFO - PID 21484 | RSS: Main: 186511360 10:42:59 INFO - PID 21484 | 10:43:01 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:43:02 INFO - PID 21484 | RSS: Main: 186286080 10:43:02 INFO - PID 21484 | 10:43:05 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:43:05 INFO - PID 21484 | RSS: Main: 186593280 10:43:05 INFO - PID 21484 | 10:43:08 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:43:09 INFO - PID 21484 | RSS: Main: 186703872 10:43:09 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | Cycle 1(1): loaded http://localhost:47898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47898/tests/kraken/driver.html?testName=ai-astar) 10:43:11 INFO - PID 21484 | RSS: Main: 188174336 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | __start_tp_report 10:43:11 INFO - PID 21484 | _x_x_mozilla_page_load 10:43:11 INFO - PID 21484 | _x_x_mozilla_page_load_details 10:43:11 INFO - PID 21484 | |i|pagename|runs| 10:43:11 INFO - PID 21484 | |0;ai-astar;104;111;111;115;111;110;110;110;111;111 10:43:11 INFO - PID 21484 | |1;audio-beat-detection;152;126;123;162;123;128;132;124;147;124 10:43:11 INFO - PID 21484 | |2;audio-dft;164;163;165;166;167;178;163;163;163;164 10:43:11 INFO - PID 21484 | |3;audio-fft;73;74;74;117;75;75;79;74;91;78 10:43:11 INFO - PID 21484 | |4;audio-oscillator;84;83;108;84;84;84;98;85;83;120 10:43:11 INFO - PID 21484 | |5;imaging-gaussian-blur;114;115;115;114;113;114;114;113;114;114 10:43:11 INFO - PID 21484 | |6;imaging-darkroom;151;151;151;150;150;151;152;150;153;151 10:43:11 INFO - PID 21484 | |7;imaging-desaturate;94;95;96;94;95;95;95;95;94;94 10:43:11 INFO - PID 21484 | |8;json-parse-financial;57;56;59;56;56;59;61;56;57;57 10:43:11 INFO - PID 21484 | |9;json-stringify-tinderbox;57;56;55;56;56;57;55;56;56;66 10:43:11 INFO - PID 21484 | |10;stanford-crypto-aes;87;86;85;87;87;87;97;88;123;95 10:43:11 INFO - PID 21484 | |11;stanford-crypto-ccm;136;141;133;138;133;131;130;141;133;137 10:43:11 INFO - PID 21484 | |12;stanford-crypto-pbkdf2;185;199;200;189;196;202;195;192;193;192 10:43:11 INFO - PID 21484 | |13;stanford-crypto-sha256-iterative;73;72;71;72;73;84;71;73;73;72 10:43:11 INFO - PID 21484 | __end_tp_report 10:43:11 INFO - PID 21484 | __start_cc_report 10:43:11 INFO - PID 21484 | _x_x_mozilla_cycle_collect,1026 10:43:11 INFO - PID 21484 | __end_cc_report 10:43:11 INFO - PID 21484 | __startTimestamp1496166191682__endTimestamp 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | ------- Summary: start ------- 10:43:11 INFO - PID 21484 | Number of tests: 14 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:1.54 10:43:11 INFO - PID 21484 | Values: 104.0 111.0 111.0 115.0 111.0 110.0 110.0 110.0 111.0 111.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:130.00 stddev:14.23 (10.9%) stddev-sans-first:13.54 10:43:11 INFO - PID 21484 | Values: 152.0 126.0 123.0 162.0 123.0 128.0 132.0 124.0 147.0 124.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:4.58 (2.8%) stddev-sans-first:4.82 10:43:11 INFO - PID 21484 | Values: 164.0 163.0 165.0 166.0 167.0 178.0 163.0 163.0 163.0 164.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.71 (18.3%) stddev-sans-first:14.23 10:43:11 INFO - PID 21484 | Values: 73.0 74.0 74.0 117.0 75.0 75.0 79.0 74.0 91.0 78.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:84.00 stddev:13.07 (15.6%) stddev-sans-first:13.60 10:43:11 INFO - PID 21484 | Values: 84.0 83.0 108.0 84.0 84.0 84.0 98.0 85.0 83.0 120.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:43:11 INFO - PID 21484 | Values: 114.0 115.0 115.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 10:43:11 INFO - PID 21484 | Values: 151.0 151.0 151.0 150.0 150.0 151.0 152.0 150.0 153.0 151.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:43:11 INFO - PID 21484 | Values: 94.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:1.71 (3.0%) stddev-sans-first:1.81 10:43:11 INFO - PID 21484 | Values: 57.0 56.0 59.0 56.0 56.0 59.0 61.0 56.0 57.0 57.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:56.00 stddev:3.23 (5.8%) stddev-sans-first:3.43 10:43:11 INFO - PID 21484 | Values: 57.0 56.0 55.0 56.0 56.0 57.0 55.0 56.0 56.0 66.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:87.00 stddev:11.53 (13.2%) stddev-sans-first:12.07 10:43:11 INFO - PID 21484 | Values: 87.0 86.0 85.0 87.0 87.0 87.0 97.0 88.0 123.0 95.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.50 stddev:3.92 (2.9%) stddev-sans-first:4.15 10:43:11 INFO - PID 21484 | Values: 136.0 141.0 133.0 138.0 133.0 131.0 130.0 141.0 133.0 137.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:195.50 stddev:5.21 (2.7%) stddev-sans-first:4.30 10:43:11 INFO - PID 21484 | Values: 185.0 199.0 200.0 189.0 196.0 202.0 195.0 192.0 193.0 192.0 10:43:11 INFO - PID 21484 | 10:43:11 INFO - PID 21484 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.00 stddev:3.81 (5.2%) stddev-sans-first:4.03 10:43:11 INFO - PID 21484 | Values: 73.0 72.0 71.0 72.0 73.0 84.0 71.0 73.0 73.0 72.0 10:43:11 INFO - PID 21484 | -------- Summary: end -------- 10:43:11 INFO - PID 21484 | 10:43:12 INFO - TEST-INFO | 21484: exit 0 10:43:12 INFO - TEST-OK | kraken | took 93297ms 10:43:12 INFO - SUITE-END | took 1241s 10:43:13 INFO - Completed test suite (00:20:41) 10:43:13 INFO - javascript benchmark 10:43:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6997.643844865442, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2699.770519505842, 2722.482728281625, 2726.7273272672737, 2754.944901101978, 2763.502569537484, 5131.153359695655, 5190.221466779984, 5211.5049070338355, 5226.895462090756, 5254.632175747699, 5153.896922061566, 5180.999999999991, 5195.662281951671, 5305.363356397238, 5311.49540793624, 4642.117997580466, 4668.603168730662, 4673.299005149238, 4698.08387364464, 4736.97631511842, 4639.234526303156, 4657.5575320344515, 4763.2378819388905, 4764.047190561884, 4787.784549695272, 4624.653151013687, 4664.930026049612, 4680.64895132863, 4698.483166851644, 4754.976225118887, 4656.976715116437, 4686.929696054562, 4717.080169366975, 4717.103750287434, 4722.268048452495, 4670.673052886299, 4677.462091859412, 4678.976605116986, 4694.413198350207, 4740.502247264057, 5191.143461328877, 5212.087884620214, 5223.294855194538, 5260.316158899357, 5263.842084737464, 5510.338759348863, 5557.3886872444, 5572.972135139339, 5590.161475778625, 5654.321481422215, 5645.096784514458, 5687.40282270364, 5700.201971723921, 5700.7149642518125, 5702.486776190163, 5245.265662807134, 5303.549198318186, 5306.151015837448, 5306.708131052752, 5354.768403267192, 5682.516986056232, 5761.8559536011935, 5764.279465066867, 5766.711664416763, 5820.156077368758, 5389.595780316414, 5457.126859702428, 5472.808451704172, 5497.972510137423, 5548.472895074961, 5666.858328541819, 5679.8864022720145, 5683.8010669626365, 5688.63023903445, 5689.715514224272, 5489.176623506426, 5638.323401191883, 5639.689817060101, 5645.040343141676, 5654.575906807006, 5537.667739935536, 5582.665040097607, 5643.238162848045, 5667.121596152603, 5694.60137790359, 4737.6683632146105, 4743.075100355467, 4750.049990002013, 4782.115308667908, 4788.329633851264, 4048.0, 4054.7769872656695, 4066.268071747055, 4071.0, 4115.97942010288, 4558.954410455853, 4599.816007359735, 4609.492955774862, 4658.324542941255, 4763.071201115749, 5643.294588176478, 5644.717764111778, 5660.8867822643315, 5663.943360566424, 5727.3699893011735, 4707.364505791743, 4733.83431579893, 4743.1225223333795, 4743.383360163157, 4757.119932812371, 4937.629677774181, 5026.748662566857, 5044.243363495505, 5049.924251136236, 5071.949280507221, 5180.792768289377, 5214.661047032083, 5248.9475105249985, 5271.815486457956, 5281.973590132025, 5528.336599608073, 5634.971825141012, 5637.154426836008, 5672.4894759471845, 5673.489385955284, 5169.638125331341, 5173.275741396133, 5192.3769147702515, 5195.636305458733, 5309.920351194813, 5504.889902201853, 5619.971900140473, 5624.634398764068, 5649.858753531194, 5663.32040155184, 5489.204065410413, 5562.916556251578, 5583.860403489945, 5719.3136823581435, 5729.312482502127, 5451.64564303319, 5452.727363631723, 5525.419830917695, 5526.530244929065, 5538.556915446674, 5426.891462170814, 5436.809711660073, 5449.836504904859, 5474.972625136849, 5553.389127195925, 5355.357357117171, 5440.455954404528, 5459.563234941115, 5459.617826752089, 5503.614746967834, 5447.0467668157125, 5483.616146869681, 5523.116301391758, 5526.889462210653, 5561.972190139023, 5358.6248962572245, 5385.192221166856, 5404.351477822686, 5404.891902162013, 5447.373552041566], "value": 5112.035050658125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2166253014994, 692.3526502719957, 698.3889097040088, 1199.6760874563863, 1233.4819375862137, 35623.821880890595, 36541.63458365419, 36610.633893661055, 36619.0, 36665.81667091661, 35515.644843551556, 35805.13558915287, 35813.64186358135, 35964.82017589915, 35969.1007724807, 6478.2226132864125, 6587.538872278942, 6664.500162487833, 6859.691313890887, 6870.45036397087, 6817.590944543318, 6939.618320992344, 6942.895856562156, 6958.930410695879, 6959.582425054513, 6919.723211071551, 6983.9650801746175, 6984.196817366017, 6986.231514533397, 6989.615571143585, 6912.930870691279, 6925.619090949996, 6932.445404367639, 6957.5129740918155, 6961.582305061713, 6672.633005184713, 6693.129893113913, 6717.56335838169, 6718.454755406284, 6725.05849181115, 33536.664633353845, 33554.83222583871, 33642.0, 33831.323373532636, 33906.0, 3028.424599326121, 3051.099925521954, 3057.7706671999467, 3060.617422822147, 3073.9538906916414, 25308.0, 25373.365665858317, 25449.363765905815, 25507.489850202892, 25544.36139096519, 3085.706857848523, 3098.0860646109227, 3118.8128712277335, 3133.8276394798277, 3153.8173185055603, 125956.0, 128749.71250287471, 148611.0, 149399.0, 149631.2518437401, 40548.0, 41018.38472422916, 41210.79394603068, 41230.79384603058, 41389.37915931264, 41995.0, 42355.0, 42472.78763606162, 42600.57399425966, 44955.70620113187, 13477.865221347856, 13533.796993045113, 13541.661458463617, 13570.59288221355, 13638.0, 10870.510827012804, 10904.727381815359, 10907.945460272647, 10924.508397122148, 10931.289466184673, 13419.463221471227, 13457.461701531829, 13470.191788492722, 13502.797458038138, 13663.863361366259, 5238.188080847474, 5304.071787437183, 5311.150215965427, 5342.652727572696, 5350.224217488442, 831.7546323834483, 856.546030603781, 898.9415687980261, 908.3966798600476, 912.4023764434173, 21592.4601884951, 22239.888800555895, 22387.0, 22639.43401414945, 22667.319980400614, 978.6819283732815, 980.3382716666222, 990.4948476277151, 1005.6932635546228, 1008.5864795433837, 11209.0, 11833.763324733458, 11843.0, 11848.229865058744, 12009.399530023464, 157635.0, 160120.0, 161002.1949890243, 161104.0, 174929.0, 48507.272390914164, 49410.258846117336, 49437.25844112341, 49480.25779613309, 49481.0, 1223.5411720604773, 1273.7134144817342, 1287.9098463107493, 1288.3043156695467, 1288.8195652608642, 25707.87146064258, 26035.0, 26665.8666706673, 27032.72967270381, 27036.864815675795, 32060.358792824478, 37504.0, 39369.63782173079, 39503.407448887716, 39738.2052358957, 168838.0, 168851.0, 169261.0, 170073.34669939635, 170394.0, 30221.395572088873, 30434.239144021576, 30550.694493055675, 30552.84723576368, 30836.537451938686, 37117.25765484621, 37452.06369840776, 38275.42586861143, 38457.0, 38674.0, 28182.577261341507, 28346.574801377585, 29132.126036218946, 29759.40481190321, 30450.84774576113, 28094.71905281003, 28187.43625127527, 28284.71715282821, 28714.85642571774, 29672.851635741685, 33020.0, 33064.33871322608, 33214.0, 33229.66770332266, 33245.335093297515, 27023.189304320902, 27680.307992300353, 27864.0, 29100.854495727384, 29286.0, 21619.0, 22717.2048978285, 22742.317730468112, 22835.429114272276, 22997.770022299563], "value": 15137.346205062227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.9838006479741, 405.2401746724891, 425.0839441004635, 432.89177705573604, 444.8398576512457, 18377.724334135, 18854.151563179672, 18857.0, 18885.244590216393, 20754.688679669816, 20215.696764548542, 20785.584288314225, 20800.16799328025, 20811.479713007182, 20825.37523874286, 5454.672719636835, 5620.775168993236, 5622.634528755638, 5628.915566266509, 5634.0, 5310.15037593985, 5565.359983601877, 5575.553955683536, 5727.627704199213, 5785.161151633031, 5490.478404551562, 5493.670379777206, 5535.501804837564, 5548.6393384430085, 5554.805581804638, 5514.338279406456, 5537.058700021006, 5555.083411237141, 5556.333240011225, 5563.165525171236, 5008.774605142778, 5023.070731914571, 5029.119904016819, 5034.194528875399, 5037.0, 23406.18078367249, 23976.0, 24372.0, 24428.63357049646, 24458.26625201247, 1612.5887898585902, 1651.983480165195, 1652.5207689769952, 1652.644681393506, 1653.7188677924782, 15357.46248881295, 15788.763168552481, 15853.762193567105, 15867.206639667971, 15879.36482540697, 2064.5870825834895, 2104.2214380679247, 2123.5646692428168, 2132.893355332227, 2169.39257008038, 94122.52938735331, 95194.0, 96194.51902740581, 96234.0, 96389.51805240999, 10773.784524309627, 11194.384308862927, 11254.49354779037, 11373.658790236306, 11546.59586914454, 16167.0, 16199.514014579581, 16213.918930405272, 16238.350465981228, 16309.184540772914, 8227.506349619041, 8334.66661333552, 8349.081601023883, 8365.205305495969, 8451.070382257947, 6658.101156343929, 7202.855942881113, 7237.131544214728, 7239.638018099074, 7878.803029924297, 7047.0, 7498.938216703703, 7550.697972081055, 7553.0, 7586.62066896653, 2012.104613447002, 2021.919123235054, 2058.1561559760426, 2062.9381118566466, 2160.6975023496725, 824.575343697996, 862.741177646716, 878.5519385113511, 891.572045418203, 897.3270047464401, 17426.564335891704, 17708.29166833338, 17785.597185013386, 18038.188281527364, 18337.99141047255, 865.1175800683268, 889.213046453893, 892.848215803315, 895.4045559702855, 914.5975770660888, 9535.809283814286, 9577.329586928987, 9687.806243875224, 9925.2059835213, 9981.45102019396, 353286.0, 354520.0, 356324.0, 359284.0, 364279.0, 83920.16079839246, 84567.57716211502, 85223.5738821302, 85657.0, 85850.0, 1031.8813336466403, 1060.1783617696192, 1071.2501249125644, 1072.8819829818713, 1080.448971024783, 15085.773713394088, 15237.847621523642, 15568.209655889717, 15690.097331993162, 16165.191740412698, 39872.0, 40609.79695101506, 40863.59136408598, 41274.79362603168, 41499.1700166001, 50256.24615630695, 50327.74836125796, 50448.24327635162, 57301.0, 60687.39312606817, 9480.336376453582, 10070.395776253448, 10103.595856165672, 10106.292559520763, 10116.29185956976, 16464.753028704818, 16488.83511164921, 16526.42157524529, 16615.0, 16718.164091795607, 13868.722625547634, 13931.651708707363, 13938.72122557523, 13957.860421396063, 14317.284135792961, 11735.76528469443, 12745.745085098431, 12898.0, 13067.51717173734, 13460.855827254793, 14354.928225358806, 14459.493917712829, 14470.565883023526, 14483.348249328596, 14519.0, 9952.154066904393, 10079.092881640687, 10125.392476451436, 10127.848082278919, 10133.493325333851, 13804.0, 13924.443022278996, 13928.60713928599, 14047.157170569799, 14053.0], "value": 9496.813803856652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.4704676988895, 1269.4224128021751, 1304.0350140895735, 1308.6859153803084, 1313.395837914559, 9923.106920377164, 10407.583696652135, 10420.739481512966, 11135.888641113586, 11542.769144617123, 11030.779384412306, 11244.4939977701, 11247.718807029829, 11259.831102533448, 11264.605738799144, 2115.830733541317, 2152.2251989283845, 2155.5581105873257, 2162.0270878104916, 2163.642998905179, 2035.226613886721, 2051.897405129745, 2073.616380969518, 2075.408508575056, 2093.6440805063176, 2093.1522733292963, 2121.6499277619173, 2122.1405330841035, 2129.4889226585665, 2143.303426386423, 1990.7909669484714, 1998.4604156877635, 2001.4195883193856, 2005.2380095563738, 2009.9296524621568, 1833.3125078095713, 1904.6000339928632, 2069.0585783468487, 2082.739657542807, 2093.8534302598823, 10858.402787846666, 10934.726631834188, 10972.122230221563, 10989.560417583287, 11006.779864402668, 5437.564994800407, 5683.0, 5684.403137670526, 5685.260916080924, 5687.317521897357, 3299.191698033997, 3396.677315655009, 3441.328940856534, 3477.8434970426138, 3484.686378225972, 1025.2054657640388, 1030.8556802047644, 1056.0442799266675, 1056.1603525197486, 1057.804306203347, 16320.673586528203, 16378.344866205338, 16429.83570164295, 16475.83524164767, 16561.337546498125, 4713.457952335457, 4773.1408346497965, 4909.656324057353, 4957.157283261854, 4962.305277261186, 11886.940565297118, 11894.167408281337, 11900.047996160287, 11914.52341906314, 11937.343446110373, 5467.890642187134, 5624.29696287964, 5640.097584386561, 5641.323041234996, 5643.717814109278, 5119.078565858107, 5122.129238029544, 5156.5616922562, 5187.351581052369, 5320.0, 3927.136030073379, 4013.478247827822, 4058.188362327546, 4089.3048181809163, 4119.237940980928, 1097.0801098078364, 1107.379867274329, 1111.8054340490382, 1118.2675347647305, 1123.1969142063465, 666.2404858461358, 692.6986760759086, 694.3230350408312, 710.8791505444087, 720.0854914258862, 5550.500454959073, 6201.0388389799655, 6207.534434917399, 6279.686015699197, 6417.593402474072, 833.9207775261341, 857.6397912876607, 867.418829384314, 879.1560102301734, 882.7395918204016, 3529.94705079424, 3642.2897534980953, 3650.4889315495852, 3753.83107760146, 3779.055236190952, 13349.132306400053, 13573.660658483617, 13573.86426135726, 13660.453581856813, 13719.1082579632, 12407.565735199225, 12602.936985315198, 12605.495780168874, 12626.242425454502, 12647.177933434297, 7421.851562968711, 7509.62451877404, 7527.172011078777, 7528.5859277739155, 7600.923990760021, 5681.630694004876, 5973.880522389615, 6044.546659000504, 6050.2437195350585, 6249.375062493714, 12479.625611231677, 12842.101052926206, 12893.806592901301, 12897.29064901402, 13078.28069456189, 13389.598312050653, 13391.330433478091, 13557.864421356055, 13612.727745445234, 13645.522406715718, 8879.289656827568, 8938.195562399414, 8973.82052358936, 9027.09729027092, 9041.728748137566, 10141.898581014391, 10254.333468324536, 10271.435071071162, 10312.329698569569, 10320.948395257976, 8220.342372610057, 8354.749357519284, 8463.915360846559, 8567.957160214408, 8568.700095496628, 8194.262516373556, 8297.294729948022, 8341.95829020851, 8362.87455688153, 8529.061803201766, 7142.5714457132735, 7314.0, 7319.74380896666, 7326.890096648448, 7327.303906128909, 4270.338097594878, 4960.925586116284, 5033.094043072282, 5049.5960323174795, 5061.392632884077, 4827.565519103297, 4864.61083113343, 4957.132501812096, 5001.099802035523, 5003.049420610072], "value": 4797.18370116116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.61841829242707, 365.4901412529521, 369.11964963561894, 370.7423340778159, 371.4150213413872, 5512.944870551293, 5618.550515958724, 5660.160562718878, 5667.716614169291, 5696.914546281809, 5397.190421436787, 5450.618456708032, 5460.781568737246, 5466.972665136679, 5481.561475081994, 4153.335466325389, 4157.937630935531, 4158.168366326731, 4159.604837540429, 4182.832686692529, 4155.065110350177, 4171.895702607444, 4176.290030694774, 4179.916401671965, 4183.916321673565, 4119.649829764474, 4131.194417088669, 4135.296999510076, 4136.97931510342, 4149.647279981205, 4136.007358234017, 4147.875563733093, 4155.854545090938, 4156.9792151039355, 4158.126793373395, 3605.7295702822394, 3610.7472476926364, 3615.891523254307, 3621.5110960020324, 3634.9273014539563, 5341.6527925685095, 5345.0, 5359.6319000015255, 5365.517103460707, 5395.325584301962, 4821.879453013703, 4839.491853355417, 4847.781849816767, 4856.732879691615, 4863.489333619989, 5782.537397008271, 5799.246098007232, 5802.622829516068, 5805.268706004593, 5819.0689489681445, 4019.155977244782, 4023.637872591481, 4030.5767894371256, 4032.7095329494573, 4049.817758200888, 5849.883002339972, 6057.273127224761, 6161.487951867437, 6184.546631541584, 6194.915889719281, 4032.5967403259438, 4076.8573099941955, 4085.816138273785, 4096.774677392712, 4110.958890411118, 4162.105147393265, 4178.644815190682, 4179.623833854967, 4188.120494696087, 4194.385161712763, 4803.135435621552, 4803.687760295569, 4809.807607695653, 4812.639052071108, 4993.800247990112, 5889.204957330706, 5927.644341339534, 5936.011436168846, 5946.524278057745, 5947.49446297061, 1562.2579274844586, 1569.3722510995465, 1578.5974576482924, 1579.336678594993, 1580.6880289359804, 1088.0262165362115, 1102.6030628973563, 1130.8021096308278, 1135.8296255561731, 1142.7371704507843, 5030.8239211627415, 5033.974830125826, 5059.392872855207, 5061.31672224245, 5091.516305950929, 6011.909821352683, 6050.878982420415, 6073.6659483727935, 6088.0, 6108.56448734547, 4960.23116416956, 5007.89826238227, 5010.348654674869, 5018.422881368616, 5030.673006254582, 3190.3938251732097, 3232.9676703233135, 3233.1917020744813, 3240.659730728287, 3240.935181296361, 5570.303712035996, 5577.107662773937, 5593.272874526286, 5595.160725891149, 5630.577706672016, 6186.4741496972365, 6217.906731398942, 6228.0, 6231.283402408781, 6235.594686345373, 5580.99084329641, 5616.522595579339, 5619.999999999918, 5625.38120806711, 5638.379778224474, 6077.817665470043, 6093.908591371044, 6097.725602347994, 6099.4510494053975, 6126.540509461719, 5940.46535811779, 5982.790602328898, 5987.64074155552, 6001.0, 6018.9398106020135, 5277.329563336398, 5377.838664840061, 5530.170474428707, 5600.7199640017025, 5626.2967129108865, 4457.531959144243, 4491.932621010622, 4503.851517863055, 4506.797194126207, 4509.819607215806, 6073.696315184135, 6090.908636370546, 6093.116498107661, 6095.512359011357, 6126.356732543197, 5737.569682273763, 5886.264216972879, 5897.498712609477, 5899.823005309848, 5904.439078287556, 5854.736536855767, 5864.296284445893, 5883.61756485827, 5896.262967129109, 5909.52723782105, 5797.797077102281, 5802.47777700009, 5827.329857066492, 5839.766409343579, 5841.4450627190345, 5952.107183922446, 5958.910616340671, 5972.193753843176, 5987.730552125252, 5993.550483713651, 5771.4805667488445, 5780.884382312246, 5801.82594522165, 5815.302163740378, 5839.445252700986], "value": 4398.13465865753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.9316064973825, 735.0444422251072, 745.6346390268768, 753.8040109571513, 767.3669222891116, 13916.791248131274, 14915.627109322273, 14926.626834329134, 15315.387384504635, 17308.567285817862, 14666.926665366685, 14667.779983300232, 14686.118832870035, 14706.852931470683, 14717.190554519497, 910.9772255693628, 934.6635211323918, 940.4827344960279, 940.7459985803829, 941.3739862991102, 845.5391811462737, 905.6965916417975, 914.89021317442, 934.1872570863359, 936.4287784451479, 974.0113784508729, 978.3054031637546, 978.3738407419257, 978.8433850583908, 979.1725991537176, 963.3834346018554, 971.2715463402449, 973.737090985437, 977.2279898879876, 979.1530326267763, 715.1275443958363, 715.3490323805364, 716.7634680555404, 718.3534818663193, 718.5293632670557, 14966.47617333399, 15263.08421494714, 15376.615584610363, 15453.918225724205, 15459.917805753601, 16463.176841157896, 17013.91493042539, 17047.0, 17087.060211688353, 17117.229724662295, 12798.552050678181, 13164.934175329063, 13305.334733263298, 13336.933315333457, 13338.93330533341, 3029.9394012119856, 3038.14931819091, 3057.755379569629, 3072.2319420144963, 3075.6616772155044, 88412.0, 89120.55439722825, 89578.10421895828, 90119.0, 90944.99999999935, 12911.22532648044, 13241.867581324064, 13266.204027758366, 13411.530596429078, 13502.594922152352, 23943.16198933029, 23967.52064958691, 24663.50672986566, 24732.38169045752, 24930.12744553968, 6374.681265936684, 6446.484281257488, 6454.612723236621, 6475.546711730133, 6507.089007538948, 2983.597214376075, 3027.076741593835, 3041.7718671099756, 3047.08587423772, 3056.190109620952, 4155.0, 4405.537418571068, 4414.168120230132, 4421.579949904818, 4457.665675074382, 768.5388766739911, 788.7751990682627, 799.7240951871595, 800.3077338102499, 802.8153524689354, 591.1428428778289, 604.1481511069371, 609.0894113300556, 621.9906701399483, 632.9588576742497, 9607.327487075838, 9907.851382229272, 9984.0, 10238.897611023944, 11332.546698132148, 609.2719200555293, 610.6397225636896, 621.7854840080165, 621.860081481663, 633.8193614819754, 4826.61387089032, 4996.7001979881325, 5003.124453220672, 5042.218456139304, 5143.254228136974, 75568.62215688996, 76297.0, 77371.61314193394, 78761.60619196868, 85056.57471712602, 66022.0, 66029.0, 67676.0, 68960.0, 69887.0, 58559.0, 60104.39895601075, 60575.394246056974, 63246.36753632497, 63708.68145659242, 10489.790204196026, 11378.203525753117, 11509.769804603693, 11647.359395233005, 11659.125565582784, 28147.296317591405, 28497.0, 30793.538096928114, 31136.0, 32309.838450807594, 60728.0, 64311.0, 64338.35661643324, 66168.33831661814, 67709.6614516944, 15571.922140389226, 15828.44600438979, 16074.276657550205, 16425.83574164243, 16772.909760865503, 17788.3774067907, 17789.46631601054, 17974.91012544929, 18194.09029548544, 18299.0, 13412.12821166621, 14214.076085054437, 14369.353379098175, 14509.854901451272, 15277.847221527643, 15512.146831923901, 15555.377784888478, 15879.364825407316, 15942.760858586898, 16341.67316653684, 14245.28773561297, 14695.0, 14731.852681473049, 14842.257887105385, 14932.552023439313, 12191.963683087037, 12307.507699691912, 12354.629361119181, 12431.813522796985, 12694.619161425171, 12764.425600847799, 13198.0, 13481.662958426117, 13499.042638817513, 13602.795958060438], "value": 7571.832964466142, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 115.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 123.0, 162.0, 123.0, 128.0, 132.0, 124.0, 147.0, 124.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 166.0, 167.0, 178.0, 163.0, 163.0, 163.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 117.0, 75.0, 75.0, 79.0, 74.0, 91.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 84.0, 84.0, 98.0, 85.0, 83.0, 120.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 152.0, 150.0, 153.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 59.0, 56.0, 56.0, 59.0, 61.0, 56.0, 57.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 57.0, 55.0, 56.0, 56.0, 66.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 87.0, 87.0, 87.0, 97.0, 88.0, 123.0, 95.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 133.0, 138.0, 133.0, 131.0, 130.0, 141.0, 133.0, 137.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 199.0, 200.0, 189.0, 196.0, 202.0, 195.0, 192.0, 193.0, 192.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 72.0, 73.0, 84.0, 71.0, 73.0, 73.0, 72.0], "value": 73.4, "unit": "score"}]}]} 10:43:13 INFO - Return code: 0 10:43:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:43:13 INFO - # TBPL SUCCESS # 10:43:13 INFO - Running post-action listener: _resource_record_post_action 10:43:13 INFO - [mozharness: 2017-05-30 17:43:13.481658Z] Finished run-tests step (success) 10:43:13 INFO - Running post-run listener: _resource_record_post_run 10:43:13 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417239040; Read time: 12; Write time: 358344 10:43:13 INFO - TinderboxPrint: CPU usage
12.7% 10:43:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:43:13 INFO - TinderboxPrint: I/O write bytes / time
417,239,040 / 358,344 10:43:13 INFO - TinderboxPrint: CPU idle
8,766.1 (87.3%) 10:43:13 INFO - TinderboxPrint: CPU user
1,222.1 (12.2%) 10:43:13 INFO - TinderboxPrint: Swap in / out
0 / 0 10:43:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107798528; Read time: 0; Write time: 148432 10:43:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:43:13 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 309440512; Read time: 0; Write time: 209912 10:43:14 INFO - Running post-run listener: _upload_blobber_files 10:43:14 INFO - Blob upload gear active. 10:43:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:43:14 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 10:43:14 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'] 10:43:14 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 10:43:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:43:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:15 INFO - (blobuploader) - INFO - Done attempting. 10:43:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:19 INFO - (blobuploader) - INFO - Done attempting. 10:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:19 INFO - (blobuploader) - INFO - Done attempting. 10:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:21 INFO - (blobuploader) - INFO - Done attempting. 10:43:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:43:21 INFO - Return code: 0 10:43:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:43:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:43:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa0be3c5db1c74a25de9a448498a41dce90482f2dbcb96ba8b88ef4e3f0929fc72c3e288c970011f061f2899da6e3fa90b299b40f0f433ae531dfdfea4faeb8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1119669e732ae8b8ba904d0a33957f9a4cf60b9933a697f7074b27e23e0e363f0566b6c8b68b9d491fb9781bfb04552fad190bf96ec839a76cb33a9d924dd9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/124389b3b6873e3d43dd48af40b4c454f3b6302b7cf5739fe7e5d2267b1542aee890236c500eb68d5bce8ef2595f168b5c0ce16a9ff498d5f1bc56f1a88a7768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c931ab31b19182d808589c461b0fc40d0f587ab195b6be81de8d9a4bef53d32a64d9750b13b78ffcfbe8b87923a6ba8642f24071f00db294e4bdbe3e55b0dbb"} 10:43:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:43:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:43:21 INFO - Contents: 10:43:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa0be3c5db1c74a25de9a448498a41dce90482f2dbcb96ba8b88ef4e3f0929fc72c3e288c970011f061f2899da6e3fa90b299b40f0f433ae531dfdfea4faeb8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1119669e732ae8b8ba904d0a33957f9a4cf60b9933a697f7074b27e23e0e363f0566b6c8b68b9d491fb9781bfb04552fad190bf96ec839a76cb33a9d924dd9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/124389b3b6873e3d43dd48af40b4c454f3b6302b7cf5739fe7e5d2267b1542aee890236c500eb68d5bce8ef2595f168b5c0ce16a9ff498d5f1bc56f1a88a7768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c931ab31b19182d808589c461b0fc40d0f587ab195b6be81de8d9a4bef53d32a64d9750b13b78ffcfbe8b87923a6ba8642f24071f00db294e4bdbe3e55b0dbb"} 10:43:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:43:21 INFO - Copying logs to upload dir... 10:43:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:43:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.912035 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-30 10:43:21.374919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:43:21.378460) ========= 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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 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/aa0be3c5db1c74a25de9a448498a41dce90482f2dbcb96ba8b88ef4e3f0929fc72c3e288c970011f061f2899da6e3fa90b299b40f0f433ae531dfdfea4faeb8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1119669e732ae8b8ba904d0a33957f9a4cf60b9933a697f7074b27e23e0e363f0566b6c8b68b9d491fb9781bfb04552fad190bf96ec839a76cb33a9d924dd9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/124389b3b6873e3d43dd48af40b4c454f3b6302b7cf5739fe7e5d2267b1542aee890236c500eb68d5bce8ef2595f168b5c0ce16a9ff498d5f1bc56f1a88a7768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c931ab31b19182d808589c461b0fc40d0f587ab195b6be81de8d9a4bef53d32a64d9750b13b78ffcfbe8b87923a6ba8642f24071f00db294e4bdbe3e55b0dbb"} build_url:https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/FzvVxojLSNqrHbcosBw55w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa0be3c5db1c74a25de9a448498a41dce90482f2dbcb96ba8b88ef4e3f0929fc72c3e288c970011f061f2899da6e3fa90b299b40f0f433ae531dfdfea4faeb8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1119669e732ae8b8ba904d0a33957f9a4cf60b9933a697f7074b27e23e0e363f0566b6c8b68b9d491fb9781bfb04552fad190bf96ec839a76cb33a9d924dd9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/124389b3b6873e3d43dd48af40b4c454f3b6302b7cf5739fe7e5d2267b1542aee890236c500eb68d5bce8ef2595f168b5c0ce16a9ff498d5f1bc56f1a88a7768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c931ab31b19182d808589c461b0fc40d0f587ab195b6be81de8d9a4bef53d32a64d9750b13b78ffcfbe8b87923a6ba8642f24071f00db294e4bdbe3e55b0dbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:43:21.402644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:43:21.402976) ========= 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=745a4373a2a16df560f216e000000264-1496164884.134855-1389570457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:43:21.485994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:43:21.486330) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:43:21.486631) ========= ========= Total master_lag: 0.16 =========