builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1472853350.91 results: success (0) buildid: 20160902133349 builduid: 6a6036702fa040ac87f0a4823cdb26ae revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:50.915624) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:50.917177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:50.917852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:50.945506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:50.945945) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 14:55:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.9M=0s 2016-09-02 14:55:52 (86.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.060929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.061465) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018502 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.115292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.116076) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0830980ffdb36a10855d02a588b4869cad6707e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d0830980ffdb36a10855d02a588b4869cad6707e --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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 14:55:52,272 truncating revision to first 12 chars 2016-09-02 14:55:52,272 Setting DEBUG logging. 2016-09-02 14:55:52,272 attempt 1/10 2016-09-02 14:55:52,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0830980ffdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 14:55:52,594 unpacking tar archive at: mozilla-central-d0830980ffdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.902176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.902496) ========= script_repo_revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.902976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.903309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:55:51.921821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-02 14:55:51.922211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:55:53 INFO - MultiFileLogger online at 20160902 14:55:53 in /builds/slave/test 14:55:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:55:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:55:53 INFO - {'append_to_log': False, 14:55:53 INFO - 'base_work_dir': '/builds/slave/test', 14:55:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:55:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:55:53 INFO - 'branch': 'Firefox-Non-PGO', 14:55:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:55:53 INFO - 'config_files': ('talos/linux_config.py',), 14:55:53 INFO - 'default_actions': ('clobber', 14:55:53 INFO - 'read-buildbot-config', 14:55:53 INFO - 'download-and-extract', 14:55:53 INFO - 'populate-webroot', 14:55:53 INFO - 'create-virtualenv', 14:55:53 INFO - 'install', 14:55:53 INFO - 'run-tests'), 14:55:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:55:53 INFO - 'download_minidump_stackwalk': True, 14:55:53 INFO - 'download_symbols': 'ondemand', 14:55:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:55:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:55:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:55:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:55:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:55:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:55:53 INFO - 'installer_path': 'installer.exe', 14:55:53 INFO - 'log_level': 'info', 14:55:53 INFO - 'log_name': 'talos', 14:55:53 INFO - 'log_to_console': True, 14:55:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:55:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:55:53 INFO - 'opt_config_files': (), 14:55:53 INFO - 'pip_index': False, 14:55:53 INFO - 'sps_profile': False, 14:55:53 INFO - 'sps_profile_interval': 0, 14:55:53 INFO - 'suite': 'dromaeojs', 14:55:53 INFO - 'system_bits': '32', 14:55:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:55:53 INFO - 'title': 'talos-linux64-ix-067', 14:55:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:55:53 INFO - 'use_talos_json': True, 14:55:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:55:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:55:53 INFO - 'work_dir': 'build'} 14:55:53 INFO - [mozharness: 2016-09-02 21:55:53.159189Z] Running clobber step. 14:55:53 INFO - Running pre-action listener: _resource_record_pre_action 14:55:53 INFO - Running main action method: clobber 14:55:53 INFO - rmtree: /builds/slave/test/build 14:55:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:55:53 INFO - Running post-action listener: _resource_record_post_action 14:55:53 INFO - [mozharness: 2016-09-02 21:55:53.614291Z] Finished clobber step (success) 14:55:53 INFO - [mozharness: 2016-09-02 21:55:53.614392Z] Running read-buildbot-config step. 14:55:53 INFO - Running pre-action listener: _resource_record_pre_action 14:55:53 INFO - Running main action method: read_buildbot_config 14:55:53 INFO - Using buildbot properties: 14:55:53 INFO - { 14:55:53 INFO - "project": "", 14:55:53 INFO - "product": "firefox", 14:55:53 INFO - "script_repo_revision": "production", 14:55:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:55:53 INFO - "repository": "", 14:55:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:55:53 INFO - "buildid": "20160902133349", 14:55:53 INFO - "pgo_build": "False", 14:55:53 INFO - "basedir": "/builds/slave/test", 14:55:53 INFO - "buildnumber": 627, 14:55:53 INFO - "slavename": "talos-linux64-ix-067", 14:55:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:55:53 INFO - "platform": "ubuntu64_hw", 14:55:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:55:53 INFO - "branch": "mozilla-central", 14:55:53 INFO - "repo_path": "mozilla-central", 14:55:53 INFO - "revision": "d0830980ffdb36a10855d02a588b4869cad6707e", 14:55:53 INFO - "stage_platform": "linux64", 14:55:53 INFO - "builduid": "6a6036702fa040ac87f0a4823cdb26ae", 14:55:53 INFO - "slavebuilddir": "test" 14:55:53 INFO - } 14:55:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:55:53 INFO - Running post-action listener: _resource_record_post_action 14:55:53 INFO - [mozharness: 2016-09-02 21:55:53.616834Z] Finished read-buildbot-config step (success) 14:55:53 INFO - [mozharness: 2016-09-02 21:55:53.616923Z] Running download-and-extract step. 14:55:53 INFO - Running pre-action listener: _resource_record_pre_action 14:55:53 INFO - Running main action method: download_and_extract 14:55:53 INFO - mkdir: /builds/slave/test/build/tests 14:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:55:53 INFO - trying https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:55:54 INFO - Downloaded 1361 bytes. 14:55:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:55:54 INFO - Using the following test package requirements: 14:55:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:55:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:55:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'jsshell-linux-x86_64.zip'], 14:55:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:55:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:55:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:55:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:55:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:55:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:55:54 INFO - trying https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:55:54 INFO - Downloading https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:55:55 INFO - Downloaded 20335151 bytes. 14:55:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:55:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:55:59 INFO - trying https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:55:59 INFO - Downloading https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:56:00 INFO - Downloaded 20335151 bytes. 14:56:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:04 INFO - trying https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:04 INFO - Downloading https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:56:06 INFO - Downloaded 14413998 bytes. 14:56:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 14:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:06 INFO - trying https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:56:06 INFO - Downloading https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:56:08 INFO - Downloaded 55762863 bytes. 14:56:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:56:08 INFO - mkdir: /builds/slave/test/properties 14:56:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:56:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:56:08 INFO - Contents: 14:56:08 INFO - build_url:https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:56:09 INFO - Running post-action listener: _resource_record_post_action 14:56:09 INFO - Running post-action listener: set_extra_try_arguments 14:56:09 INFO - [mozharness: 2016-09-02 21:56:09.161313Z] Finished download-and-extract step (success) 14:56:09 INFO - [mozharness: 2016-09-02 21:56:09.161541Z] Running populate-webroot step. 14:56:09 INFO - Running pre-action listener: _resource_record_pre_action 14:56:09 INFO - Running main action method: populate_webroot 14:56:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:56:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:56:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:56:09 INFO - '--tppagecycles', 14:56:09 INFO - '7'], 14:56:09 INFO - 'tests': ['tsvgm']}}, 14:56:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:56:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:56:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:56:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:56:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['damp', 'tps']}, 14:56:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'tests': ['damp', 'tps']}, 14:56:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['dromaeo_dom']}, 14:56:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:56:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['basic_compositor_video']}, 14:56:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:56:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['a11yr', 14:56:09 INFO - 'ts_paint', 14:56:09 INFO - 'tpaint', 14:56:09 INFO - 'sessionrestore', 14:56:09 INFO - 'sessionrestore_no_auto_restore', 14:56:09 INFO - 'tabpaint']}, 14:56:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['tsvgx', 14:56:09 INFO - 'tsvgr_opacity', 14:56:09 INFO - 'tart', 14:56:09 INFO - 'tscrollx', 14:56:09 INFO - 'cart']}, 14:56:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:56:09 INFO - 'tsvgr_opacity', 14:56:09 INFO - 'tart', 14:56:09 INFO - 'tscrollx', 14:56:09 INFO - 'cart']}, 14:56:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'talos_options': ['--disable-e10s'], 14:56:09 INFO - 'tests': ['tp5o']}, 14:56:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'tests': ['tp5o']}, 14:56:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'talos_options': ['--disable-e10s', 14:56:09 INFO - '--xperf_path', 14:56:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:09 INFO - 'tests': ['tp5n']}, 14:56:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:09 INFO - 'talos_options': ['--xperf_path', 14:56:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:09 INFO - 'tests': ['tp5n']}}, 14:56:09 INFO - 'talos.zip': {'path': '', 14:56:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:56:09 INFO - Running post-action listener: _resource_record_post_action 14:56:09 INFO - [mozharness: 2016-09-02 21:56:09.177211Z] Finished populate-webroot step (success) 14:56:09 INFO - [mozharness: 2016-09-02 21:56:09.177307Z] Running create-virtualenv step. 14:56:09 INFO - Running pre-action listener: _resource_record_pre_action 14:56:09 INFO - Running main action method: create_virtualenv 14:56:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:56:09 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 14:56:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:56:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:56:09 INFO - Using real prefix '/usr' 14:56:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:56:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:56:11 INFO - Installing pip.................done. 14:56:11 INFO - Return code: 0 14:56:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:56:11 INFO - Using env: {'DISPLAY': ':0', 14:56:11 INFO - 'HOME': '/home/cltbld', 14:56:11 INFO - 'LANG': 'en_US.UTF-8', 14:56:11 INFO - 'LANGUAGE': 'en_US:en', 14:56:11 INFO - 'LOGNAME': 'cltbld', 14:56:11 INFO - 'MAIL': '/var/mail/cltbld', 14:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:11 INFO - 'MOZ_NO_REMOTE': '1', 14:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:11 INFO - 'NO_EM_RESTART': '1', 14:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:11 INFO - 'PWD': '/builds/slave/test', 14:56:11 INFO - 'SHELL': '/bin/bash', 14:56:11 INFO - 'SHLVL': '1', 14:56:11 INFO - 'TERM': 'linux', 14:56:11 INFO - 'TMOUT': '86400', 14:56:11 INFO - 'USER': 'cltbld', 14:56:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:11 INFO - '_': '/tools/buildbot/bin/python'} 14:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:11 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 14:56:11 INFO - Cleaning up... 14:56:11 INFO - Return code: 0 14:56:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:56:11 INFO - Using env: {'DISPLAY': ':0', 14:56:11 INFO - 'HOME': '/home/cltbld', 14:56:11 INFO - 'LANG': 'en_US.UTF-8', 14:56:11 INFO - 'LANGUAGE': 'en_US:en', 14:56:11 INFO - 'LOGNAME': 'cltbld', 14:56:11 INFO - 'MAIL': '/var/mail/cltbld', 14:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:11 INFO - 'MOZ_NO_REMOTE': '1', 14:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:11 INFO - 'NO_EM_RESTART': '1', 14:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:11 INFO - 'PWD': '/builds/slave/test', 14:56:11 INFO - 'SHELL': '/bin/bash', 14:56:11 INFO - 'SHLVL': '1', 14:56:11 INFO - 'TERM': 'linux', 14:56:11 INFO - 'TMOUT': '86400', 14:56:11 INFO - 'USER': 'cltbld', 14:56:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:11 INFO - '_': '/tools/buildbot/bin/python'} 14:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:12 INFO - Downloading/unpacking psutil>=3.1.1 14:56:12 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 14:56:12 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 14:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:12 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 14:56:12 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 14:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:56:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:14 INFO - Installing collected packages: psutil 14:56:14 INFO - Running setup.py install for psutil 14:56:14 INFO - building 'psutil._psutil_linux' extension 14:56:14 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 14:56:14 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 14:56:14 INFO - building 'psutil._psutil_posix' extension 14:56:14 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 14:56:14 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 14:56:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:14 INFO - Successfully installed psutil 14:56:14 INFO - Cleaning up... 14:56:14 INFO - Return code: 0 14:56:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:56:14 INFO - Using env: {'DISPLAY': ':0', 14:56:14 INFO - 'HOME': '/home/cltbld', 14:56:14 INFO - 'LANG': 'en_US.UTF-8', 14:56:14 INFO - 'LANGUAGE': 'en_US:en', 14:56:14 INFO - 'LOGNAME': 'cltbld', 14:56:14 INFO - 'MAIL': '/var/mail/cltbld', 14:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:14 INFO - 'MOZ_NO_REMOTE': '1', 14:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:14 INFO - 'NO_EM_RESTART': '1', 14:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:14 INFO - 'PWD': '/builds/slave/test', 14:56:14 INFO - 'SHELL': '/bin/bash', 14:56:14 INFO - 'SHLVL': '1', 14:56:14 INFO - 'TERM': 'linux', 14:56:14 INFO - 'TMOUT': '86400', 14:56:14 INFO - 'USER': 'cltbld', 14:56:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:14 INFO - '_': '/tools/buildbot/bin/python'} 14:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:56:14 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 14:56:14 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 14:56:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:14 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 14:56:14 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 14:56:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:56:16 INFO - Installing collected packages: mozsystemmonitor 14:56:16 INFO - Running setup.py install for mozsystemmonitor 14:56:16 INFO - Successfully installed mozsystemmonitor 14:56:16 INFO - Cleaning up... 14:56:17 INFO - Return code: 0 14:56:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:17 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:56:17 INFO - Using env: {'DISPLAY': ':0', 14:56:17 INFO - 'HOME': '/home/cltbld', 14:56:17 INFO - 'LANG': 'en_US.UTF-8', 14:56:17 INFO - 'LANGUAGE': 'en_US:en', 14:56:17 INFO - 'LOGNAME': 'cltbld', 14:56:17 INFO - 'MAIL': '/var/mail/cltbld', 14:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:17 INFO - 'MOZ_NO_REMOTE': '1', 14:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:17 INFO - 'NO_EM_RESTART': '1', 14:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:17 INFO - 'PWD': '/builds/slave/test', 14:56:17 INFO - 'SHELL': '/bin/bash', 14:56:17 INFO - 'SHLVL': '1', 14:56:17 INFO - 'TERM': 'linux', 14:56:17 INFO - 'TMOUT': '86400', 14:56:17 INFO - 'USER': 'cltbld', 14:56:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:17 INFO - '_': '/tools/buildbot/bin/python'} 14:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:17 INFO - Downloading/unpacking jsonschema==2.5.1 14:56:17 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 14:56:17 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 14:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:17 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 14:56:17 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 14:56:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:56:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:56:19 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 14:56:19 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 14:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:19 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 14:56:19 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 14:56:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:56:19 INFO - warning: no files found matching '*.txt' 14:56:19 INFO - no previously-included directories found matching 'build' 14:56:19 INFO - no previously-included directories found matching 'dist' 14:56:19 INFO - no previously-included directories found matching '.git*' 14:56:19 INFO - Installing collected packages: jsonschema, functools32 14:56:19 INFO - Running setup.py install for functools32 14:56:19 INFO - warning: no files found matching '*.txt' 14:56:19 INFO - no previously-included directories found matching 'build' 14:56:19 INFO - no previously-included directories found matching 'dist' 14:56:19 INFO - no previously-included directories found matching '.git*' 14:56:19 INFO - Successfully installed jsonschema functools32 14:56:19 INFO - Cleaning up... 14:56:19 INFO - Return code: 0 14:56:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:56:19 INFO - Using env: {'DISPLAY': ':0', 14:56:19 INFO - 'HOME': '/home/cltbld', 14:56:19 INFO - 'LANG': 'en_US.UTF-8', 14:56:19 INFO - 'LANGUAGE': 'en_US:en', 14:56:19 INFO - 'LOGNAME': 'cltbld', 14:56:19 INFO - 'MAIL': '/var/mail/cltbld', 14:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:19 INFO - 'MOZ_NO_REMOTE': '1', 14:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:19 INFO - 'NO_EM_RESTART': '1', 14:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:19 INFO - 'PWD': '/builds/slave/test', 14:56:19 INFO - 'SHELL': '/bin/bash', 14:56:19 INFO - 'SHLVL': '1', 14:56:19 INFO - 'TERM': 'linux', 14:56:19 INFO - 'TMOUT': '86400', 14:56:19 INFO - 'USER': 'cltbld', 14:56:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:19 INFO - '_': '/tools/buildbot/bin/python'} 14:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:56:19 INFO - Cleaning up... 14:56:19 INFO - Return code: 0 14:56:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:56:19 INFO - Using env: {'DISPLAY': ':0', 14:56:19 INFO - 'HOME': '/home/cltbld', 14:56:19 INFO - 'LANG': 'en_US.UTF-8', 14:56:19 INFO - 'LANGUAGE': 'en_US:en', 14:56:19 INFO - 'LOGNAME': 'cltbld', 14:56:19 INFO - 'MAIL': '/var/mail/cltbld', 14:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:19 INFO - 'MOZ_NO_REMOTE': '1', 14:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:19 INFO - 'NO_EM_RESTART': '1', 14:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:19 INFO - 'PWD': '/builds/slave/test', 14:56:19 INFO - 'SHELL': '/bin/bash', 14:56:19 INFO - 'SHLVL': '1', 14:56:19 INFO - 'TERM': 'linux', 14:56:19 INFO - 'TMOUT': '86400', 14:56:19 INFO - 'USER': 'cltbld', 14:56:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:19 INFO - '_': '/tools/buildbot/bin/python'} 14:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:20 INFO - Downloading/unpacking blobuploader==1.2.4 14:56:20 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 14:56:20 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 14:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:20 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 14:56:20 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 14:56:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:56:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:56:21 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 14:56:21 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 14:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:21 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 14:56:21 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 14:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:56:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:56:22 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 14:56:22 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 14:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:22 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 14:56:22 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 14:56:22 INFO - Downloading docopt-0.6.1.tar.gz 14:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:56:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:56:22 INFO - Running setup.py install for blobuploader 14:56:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:56:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:56:22 INFO - Running setup.py install for requests 14:56:23 INFO - Running setup.py install for docopt 14:56:23 INFO - Successfully installed blobuploader requests docopt 14:56:23 INFO - Cleaning up... 14:56:23 INFO - Return code: 0 14:56:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:56:23 INFO - Using env: {'DISPLAY': ':0', 14:56:23 INFO - 'HOME': '/home/cltbld', 14:56:23 INFO - 'LANG': 'en_US.UTF-8', 14:56:23 INFO - 'LANGUAGE': 'en_US:en', 14:56:23 INFO - 'LOGNAME': 'cltbld', 14:56:23 INFO - 'MAIL': '/var/mail/cltbld', 14:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:23 INFO - 'MOZ_NO_REMOTE': '1', 14:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:23 INFO - 'NO_EM_RESTART': '1', 14:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:23 INFO - 'PWD': '/builds/slave/test', 14:56:23 INFO - 'SHELL': '/bin/bash', 14:56:23 INFO - 'SHLVL': '1', 14:56:23 INFO - 'TERM': 'linux', 14:56:23 INFO - 'TMOUT': '86400', 14:56:23 INFO - 'USER': 'cltbld', 14:56:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:23 INFO - '_': '/tools/buildbot/bin/python'} 14:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:23 INFO - Running setup.py (path:/tmp/pip-kwmlij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:23 INFO - Running setup.py (path:/tmp/pip-I6WU2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:23 INFO - Running setup.py (path:/tmp/pip-IX21d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:23 INFO - Running setup.py (path:/tmp/pip-F2plbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:23 INFO - Running setup.py (path:/tmp/pip-Yxf20d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:23 INFO - Running setup.py (path:/tmp/pip-6FC6Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:23 INFO - Running setup.py (path:/tmp/pip-YFa1Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:23 INFO - Running setup.py (path:/tmp/pip-yczifX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:24 INFO - Running setup.py (path:/tmp/pip-uwCVMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:24 INFO - Running setup.py (path:/tmp/pip-SDKjOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:24 INFO - Running setup.py (path:/tmp/pip-pC0rHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:24 INFO - Running setup.py (path:/tmp/pip-YVY901-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:24 INFO - Running setup.py (path:/tmp/pip-yCMZvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:24 INFO - Running setup.py (path:/tmp/pip-QTYWtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:24 INFO - Running setup.py (path:/tmp/pip-1VB8Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:24 INFO - Running setup.py (path:/tmp/pip-SCiwZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:24 INFO - Running setup.py (path:/tmp/pip-aGQWMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:56:24 INFO - Running setup.py install for manifestparser 14:56:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:56:24 INFO - Running setup.py install for mozcrash 14:56:24 INFO - Running setup.py install for mozdebug 14:56:24 INFO - Running setup.py install for mozdevice 14:56:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for mozfile 14:56:25 INFO - Running setup.py install for mozhttpd 14:56:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for mozinfo 14:56:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for mozInstall 14:56:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for mozleak 14:56:25 INFO - Running setup.py install for mozlog 14:56:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for moznetwork 14:56:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:56:25 INFO - Running setup.py install for mozprocess 14:56:25 INFO - Running setup.py install for mozprofile 14:56:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:56:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:56:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:56:26 INFO - Running setup.py install for mozrunner 14:56:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:56:26 INFO - Running setup.py install for mozscreenshot 14:56:26 INFO - Running setup.py install for moztest 14:56:26 INFO - Running setup.py install for mozversion 14:56:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:56:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:56:26 INFO - Cleaning up... 14:56:26 INFO - Return code: 0 14:56:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:56:26 INFO - Using env: {'DISPLAY': ':0', 14:56:26 INFO - 'HOME': '/home/cltbld', 14:56:26 INFO - 'LANG': 'en_US.UTF-8', 14:56:26 INFO - 'LANGUAGE': 'en_US:en', 14:56:26 INFO - 'LOGNAME': 'cltbld', 14:56:26 INFO - 'MAIL': '/var/mail/cltbld', 14:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:26 INFO - 'MOZ_NO_REMOTE': '1', 14:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:26 INFO - 'NO_EM_RESTART': '1', 14:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:26 INFO - 'PWD': '/builds/slave/test', 14:56:26 INFO - 'SHELL': '/bin/bash', 14:56:26 INFO - 'SHLVL': '1', 14:56:26 INFO - 'TERM': 'linux', 14:56:26 INFO - 'TMOUT': '86400', 14:56:26 INFO - 'USER': 'cltbld', 14:56:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:26 INFO - '_': '/tools/buildbot/bin/python'} 14:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:26 INFO - Running setup.py (path:/tmp/pip-W4cW1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:26 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)) 14:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:26 INFO - Running setup.py (path:/tmp/pip-2QUqEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:26 INFO - Running setup.py (path:/tmp/pip-XpsGfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:26 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)) 14:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:26 INFO - Running setup.py (path:/tmp/pip-Oi6MsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:27 INFO - Running setup.py (path:/tmp/pip-TpcxbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:27 INFO - Running setup.py (path:/tmp/pip-3r5DEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:27 INFO - Running setup.py (path:/tmp/pip-_IkmBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:27 INFO - Running setup.py (path:/tmp/pip-bqQ4z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:27 INFO - Running setup.py (path:/tmp/pip-OZeJby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:27 INFO - Running setup.py (path:/tmp/pip-qzBcYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:27 INFO - Running setup.py (path:/tmp/pip-A66Xhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:27 INFO - Running setup.py (path:/tmp/pip-Ifx0Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:27 INFO - Running setup.py (path:/tmp/pip-XcL87V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:27 INFO - Running setup.py (path:/tmp/pip-4IC_oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:27 INFO - Running setup.py (path:/tmp/pip-J487pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:27 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:27 INFO - Running setup.py (path:/tmp/pip-naET3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 14:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:27 INFO - Running setup.py (path:/tmp/pip-QJo5gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:27 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)) 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:56:27 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)) 14:56:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:56:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:56:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:56:27 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 14:56:27 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 14:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:27 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 14:56:27 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 14:56:29 INFO - Downloading blessings-1.6.tar.gz 14:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:56:29 INFO - Installing collected packages: blessings 14:56:29 INFO - Running setup.py install for blessings 14:56:30 INFO - Successfully installed blessings 14:56:30 INFO - Cleaning up... 14:56:30 INFO - Return code: 0 14:56:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:30 INFO - Reading from file tmpfile_stdout 14:56:30 INFO - Current package versions: 14:56:30 INFO - argparse == 1.2.1 14:56:30 INFO - blessings == 1.6 14:56:30 INFO - blobuploader == 1.2.4 14:56:30 INFO - docopt == 0.6.1 14:56:30 INFO - functools32 == 3.2.3-2 14:56:30 INFO - jsonschema == 2.5.1 14:56:30 INFO - manifestparser == 1.1 14:56:30 INFO - mozInstall == 1.12 14:56:30 INFO - mozcrash == 0.17 14:56:30 INFO - mozdebug == 0.1 14:56:30 INFO - mozdevice == 0.48 14:56:30 INFO - mozfile == 1.2 14:56:30 INFO - mozhttpd == 0.7 14:56:30 INFO - mozinfo == 0.9 14:56:30 INFO - mozleak == 0.1 14:56:30 INFO - mozlog == 3.3 14:56:30 INFO - moznetwork == 0.27 14:56:30 INFO - mozprocess == 0.23 14:56:30 INFO - mozprofile == 0.28 14:56:30 INFO - mozrunner == 6.12 14:56:30 INFO - mozscreenshot == 0.1 14:56:30 INFO - mozsystemmonitor == 0.3 14:56:30 INFO - moztest == 0.7 14:56:30 INFO - mozversion == 1.4 14:56:30 INFO - psutil == 3.1.1 14:56:30 INFO - requests == 1.2.3 14:56:30 INFO - wsgiref == 0.1.2 14:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:56:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:56:30 INFO - Using env: {'DISPLAY': ':0', 14:56:30 INFO - 'HOME': '/home/cltbld', 14:56:30 INFO - 'LANG': 'en_US.UTF-8', 14:56:30 INFO - 'LANGUAGE': 'en_US:en', 14:56:30 INFO - 'LOGNAME': 'cltbld', 14:56:30 INFO - 'MAIL': '/var/mail/cltbld', 14:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:30 INFO - 'MOZ_NO_REMOTE': '1', 14:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:30 INFO - 'NO_EM_RESTART': '1', 14:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:30 INFO - 'PWD': '/builds/slave/test', 14:56:30 INFO - 'SHELL': '/bin/bash', 14:56:30 INFO - 'SHLVL': '1', 14:56:30 INFO - 'TERM': 'linux', 14:56:30 INFO - 'TMOUT': '86400', 14:56:30 INFO - 'USER': 'cltbld', 14:56:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:30 INFO - '_': '/tools/buildbot/bin/python'} 14:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 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)) 14:56:30 INFO - Cleaning up... 14:56:30 INFO - Return code: 0 14:56:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e593df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1973420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', '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 14:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:56:30 INFO - Using env: {'DISPLAY': ':0', 14:56:30 INFO - 'HOME': '/home/cltbld', 14:56:30 INFO - 'LANG': 'en_US.UTF-8', 14:56:30 INFO - 'LANGUAGE': 'en_US:en', 14:56:30 INFO - 'LOGNAME': 'cltbld', 14:56:30 INFO - 'MAIL': '/var/mail/cltbld', 14:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:30 INFO - 'MOZ_NO_REMOTE': '1', 14:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:30 INFO - 'NO_EM_RESTART': '1', 14:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:30 INFO - 'PWD': '/builds/slave/test', 14:56:30 INFO - 'SHELL': '/bin/bash', 14:56:30 INFO - 'SHLVL': '1', 14:56:30 INFO - 'TERM': 'linux', 14:56:30 INFO - 'TMOUT': '86400', 14:56:30 INFO - 'USER': 'cltbld', 14:56:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:30 INFO - '_': '/tools/buildbot/bin/python'} 14:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:56:30 INFO - Cleaning up... 14:56:30 INFO - Return code: 0 14:56:30 INFO - Running post-action listener: _resource_record_post_action 14:56:30 INFO - Running post-action listener: _start_resource_monitoring 14:56:30 INFO - Starting resource monitoring. 14:56:30 INFO - [mozharness: 2016-09-02 21:56:30.781729Z] Finished create-virtualenv step (success) 14:56:30 INFO - [mozharness: 2016-09-02 21:56:30.782236Z] Running install step. 14:56:30 INFO - Running pre-action listener: _resource_record_pre_action 14:56:30 INFO - Running main action method: install 14:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:30 INFO - Reading from file tmpfile_stdout 14:56:30 INFO - Detecting whether we're running mozinstall >=1.0... 14:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:56:31 INFO - Reading from file tmpfile_stdout 14:56:31 INFO - Output received: 14:56:31 INFO - Usage: mozinstall [options] installer 14:56:31 INFO - Options: 14:56:31 INFO - -h, --help show this help message and exit 14:56:31 INFO - -d DEST, --destination=DEST 14:56:31 INFO - Directory to install application into. [default: 14:56:31 INFO - "/builds/slave/test"] 14:56:31 INFO - --app=APP Application being installed. [default: firefox] 14:56:31 INFO - mkdir: /builds/slave/test/build/application 14:56:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:56:47 INFO - Reading from file tmpfile_stdout 14:56:47 INFO - Output received: 14:56:47 INFO - /builds/slave/test/build/application/firefox/firefox 14:56:47 INFO - Running post-action listener: _resource_record_post_action 14:56:47 INFO - [mozharness: 2016-09-02 21:56:47.171076Z] Finished install step (success) 14:56:47 INFO - [mozharness: 2016-09-02 21:56:47.171355Z] Running run-tests step. 14:56:47 INFO - Running pre-action listener: _resource_record_pre_action 14:56:47 INFO - Running main action method: run_tests 14:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:56:47 INFO - Python 2.7.3 14:56:47 INFO - Return code: 0 14:56:47 INFO - grabbing minidump binary from tooltool 14:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 14:56:47 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 0x1a01d20>, '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 0x1a02c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a030b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:56:47 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 14:56:47 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 14:56:47 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 14:56:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:56:47 INFO - Return code: 0 14:56:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:56:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:56:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:56:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:56:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:56:47 INFO - Using env: {'DISPLAY': ':0', 14:56:47 INFO - 'HOME': '/home/cltbld', 14:56:47 INFO - 'LANG': 'en_US.UTF-8', 14:56:47 INFO - 'LANGUAGE': 'en_US:en', 14:56:47 INFO - 'LOGNAME': 'cltbld', 14:56:47 INFO - 'MAIL': '/var/mail/cltbld', 14:56:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:56:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:47 INFO - 'MOZ_NO_REMOTE': '1', 14:56:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:47 INFO - 'NO_EM_RESTART': '1', 14:56:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:47 INFO - 'PWD': '/builds/slave/test', 14:56:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:56:47 INFO - 'SHELL': '/bin/bash', 14:56:47 INFO - 'SHLVL': '1', 14:56:47 INFO - 'TERM': 'linux', 14:56:47 INFO - 'TMOUT': '86400', 14:56:47 INFO - 'USER': 'cltbld', 14:56:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329', 14:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:47 INFO - '_': '/tools/buildbot/bin/python'} 14:56:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:56:47 INFO - mozversion application_buildid: 20160902133349 14:56:47 INFO - mozversion application_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 14:56:47 INFO - mozversion application_display_name: Nightly 14:56:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:56:47 INFO - mozversion application_name: Firefox 14:56:47 INFO - mozversion application_remotingname: firefox 14:56:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:56:47 INFO - mozversion application_vendor: Mozilla 14:56:47 INFO - mozversion application_version: 51.0a1 14:56:47 INFO - mozversion platform_buildid: 20160902133349 14:56:47 INFO - mozversion platform_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 14:56:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:56:47 INFO - mozversion platform_version: 51.0a1 14:56:47 INFO - using testdate: 1472853407 14:56:47 INFO - actual date: 1472853407 14:56:47 INFO - starting webserver on 'localhost:53303' 14:56:47 INFO - SUITE-START | Running 2 tests 14:56:47 INFO - TEST-START | dromaeo_css 14:56:47 INFO - operating with platform_type : linux_ 14:56:47 INFO - Initialising browser for dromaeo_css test... 14:56:47 INFO - TEST-INFO | started process 2935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3ccxr/profile http://localhost:53303/getInfo.html) 14:56:51 INFO - PROCESS | 2935 | __metrics Screen width/height:1600/1200 14:56:51 INFO - PROCESS | 2935 | colorDepth:24 14:56:51 INFO - PROCESS | 2935 | Browser inner width/height: 1024/697 14:56:51 INFO - PROCESS | 2935 | __metrics 14:56:51 INFO - PROCESS | 2935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:56:51 INFO - PROCESS | 2935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:56:53 INFO - TEST-INFO | 2935: exit 0 14:56:53 INFO - Browser initialized. 14:56:53 INFO - Running cycle 1/1 for dromaeo_css test... 14:56:53 INFO - TEST-INFO | started process 3018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3ccxr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:05 INFO - PROCESS | 3018 | RSS: Main: 180998144 14:57:05 INFO - PROCESS | 3018 | 14:57:56 INFO - PROCESS | 3018 | 1472853476756 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:00:10 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53303/tests/dromaeo/cssquery-ext.html) 15:00:11 INFO - PROCESS | 3018 | RSS: Main: 272617472 15:00:11 INFO - PROCESS | 3018 | 15:03:14 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-ext.html (next: http://localhost:53303/tests/dromaeo/cssquery-jquery.html) 15:03:14 INFO - PROCESS | 3018 | RSS: Main: 268763136 15:03:14 INFO - PROCESS | 3018 | 15:06:17 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53303/tests/dromaeo/cssquery-mootools.html) 15:06:17 INFO - PROCESS | 3018 | RSS: Main: 218959872 15:06:17 INFO - PROCESS | 3018 | 15:09:19 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53303/tests/dromaeo/cssquery-prototype.html) 15:09:20 INFO - PROCESS | 3018 | RSS: Main: 217079808 15:09:20 INFO - PROCESS | 3018 | 15:12:23 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53303/tests/dromaeo/cssquery-yui.html) 15:12:24 INFO - PROCESS | 3018 | RSS: Main: 218107904 15:12:24 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:53303/tests/dromaeo/cssquery-yui.html (next: http://localhost:53303/tests/dromaeo/cssquery-dojo.html) 15:15:27 INFO - PROCESS | 3018 | RSS: Main: 292970496 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | __start_tp_report 15:15:27 INFO - PROCESS | 3018 | _x_x_mozilla_page_load 15:15:27 INFO - PROCESS | 3018 | _x_x_mozilla_page_load_details 15:15:27 INFO - PROCESS | 3018 | |i|pagename|runs| 15:15:27 INFO - PROCESS | 3018 | |0;dojo.html;2609.412882101527;2610.2038878142166;2616.620590014447;2664.7868170546344;2674.197740677796;4652.371929789478;4731.621470282378;4766.475687674358;4818.036392721457;4861.368022157119;4777.235642297233;4803.831865884695;4862.3922009748785;4892.241702536104;4908.582770464514;4380.342948557726;4394.8901277468;4454.443194600675;4517.934317181489;4530.093981203756;4500.167469018242;4538.659600529957;4552.521985191557;4568.291914753218;4584.381108550353;4368.868933931987;4371.7540500957075;4416.734995900256;4433.866983990453;4451.9777401113115;4457.086297309076;4513.7517436540975;4524.773761311922;4528.139653465831;4528.977355113203;4405.5016407177245;4405.581469760367;4417.315316126005;4427.512973572904;4471.150481408522;4670.602998745111;4835.226363781778;4849.927251091236;4854.708717476963;4883.19427294496;5072.34059572257;5116.437191908887;5119.488051194888;5123.410807757118;5184.170532714786;5154.871128221787;5163.7676304566385;5164.070467315882;5168.715720635363;5172.353455818023;4766.976165119152;4784.832530861403;4790.688605240648;4797.976010119927;4854.708717476892;5254.133068043807;5282.683039017671;5328.200769884548;5364.329458817648;5373.623846330719;5101.20931255656;5103.209002604603;5113.744312784346;5155.819546315861;5166.870828229325;5129.743512824344;5163.561097306696;5165.586753059746;5172.456892026358;5242.606804489678;5030.37120359955;5057.317262169634;5073.188289873602;5117.053345131163;5128.948710512922;5064.873378165576;5074.188129899198;5083.669561478492;5135.255387968724;5152.665076770073;4379.890502737457;4384.167008268419;4384.4081049058605;4398.714083584621;4443.577860103285;3798.1264309209037;3801.7718936863876;3801.9354580717445;3811.8094095295123;3832.5017747692623;4408.140412619572;4420.425344705168;4429.49060857999;4474.172278128557;4485.775711214426;5117.795288188431;5153.665011774223;5163.561097306696;5182.792688292426;5236.345456817898;4361;4373.409589705413;4384.824607015684;4431.446069241345;4470.798814053375;4649.837255696035;4655.068986202706;4670.065986802653;4720.268358404453;4733.786979585927;4860.1251774680895;4870.561649451566;4873;4875.975620121877;4929.605631549539;5081.7713202905215;5151.768170432414;5153.330067091254;5172.612054095883;5228.555572776357;4865.756712164307;4874.610031197567;4902.166631672696;4948.282499037691;4964.131277026579;5135.794568217229;5137.049645815536;5143.305653736697;5153.0466863630345;5212.582993360446;5055.342805435417;5157.6647517911215;5180.6891586504935;5198.37619485649;5201.7399130044105;5051.3433253676785;5053.974730126326;5062.949370506248;5118.74406279692;5127.282180494659;5011.824586139468;5041.571466425395;5047.545720885138;5054.898902022012;5115.079285728456;4852.95147048525;4914.827981020647;4940.2342636891335;4971.552560269449;4972.378452693413;5034.622403319692;5064.8480545582215;5066.392032956069;5115.130427827204;5126.077306084941;4898.559129678346;4930.580900623487;4941.975290123526;4946;5005.149124648746 15:15:27 INFO - PROCESS | 3018 | |1;ext.html;526.3473293116535;538.5368583018604;554.5369616370331;564.2072887592933;577.1659951370269;34925.47611785822;36800.26399472009;36860.44709329356;36872.07819804503;39779.801100994526;36713.816430917876;37073.073173170684;37154.8142259289;37186.44220336697;37212.255754884885;7441.702331906731;7579.772606821804;7585.962070189641;7586.241375862425;7619.42854285928;7504.174540800507;7567.243275672444;7582.772516824504;7583.355414789722;7586.241375862425;7601;7636.465447418683;7636.885446718304;7638.274363935418;7638.9618051909665;7524.623768811538;7561.092668879714;7571.848563028763;7592.620368981528;7594.772156835304;7339.816504587375;7406.925930740677;7417.184109747924;7425.9628701856145;7433.1080270367365;34024;34199.6580034199;34277.6572234277;34288.82855585731;34312.82843585791;2666.679998400185;2752.3119220194953;2828.830270183775;2832.306085009186;3096.1330827368374;25772.613410798855;26026.21921342363;26031;26613.866930665416;27276.863615681992;3366.1921138926728;3485.9477107843404;3524.4537096750046;3524.7503094720737;3570.7500474966764;242146;243210;243370;243490;243839;45108.54891451044;45115.54884451179;45174;45418.54581454209;45847.77076114598;46221.30668039982;47855.76072119617;48019.75990120027;50382;51148.74425627848;13262.071654984058;13366.53217137415;13367.197968121944;13376.531821386205;13407.262600557064;8847.46915185091;10505.474726263656;10593.152547796159;10606.098481628993;10606.416647084485;13267;13774;13804.309784510735;14137.929310353587;14169.78745318821;5284.894302114013;5375.596830237748;5423.728813559306;5490.505854473036;5506.752196151183;726.4370113162341;782.2529484342439;870.3037569944146;875.8992715837633;906.8322360363354;24376.39059023503;25748.742512574634;26014.34964125874;26039.73960260373;26084.478310434064;896.8699538567001;911.1162172692477;924.9953750231206;936.2229349639782;985.2364417576435;13160.276184809927;13395.12931659439;13557.389917453738;13559.86440135586;13641.590752277447;354394;356594;357510;357805;358328;42412.78793606012;42586;42624.786876065424;42652.3602145968;42785.35821962673;1033.2302434685907;1035.4460363705382;1040.7138037039874;1060;1066.0192622787054;24967.006598679975;25698.229053128434;26683.16536466138;27167;27231.45537089287;36131.27737445289;36548.26903461969;36620.26759464849;36627.45058824067;36671.266574668894;306165;306322;307379;307510;308336;20013;20850.478738031063;20882.895585521976;20886.582268354243;22269;33735.83132084324;36783.44824827576;36957.646169454165;37781.62218377891;37855.24289514139;31838.840805795822;32168.517472238404;32260.516092259106;32452.513212302307;32766;31805.681943181196;32215.677843221267;32255.516167257978;32319;33393.49909751307;31876;31995.200119996254;32408.675913240564;32540.349193016482;32896.67103329032;27883.094395736418;29567.704322957357;29819.254518637208;29851.253718657208;30115.548266776455;23150.57091450993;23281.88359058194;23442.531149377257;23443.41391465227;23520.764792351856 15:15:27 INFO - PROCESS | 3018 | |2;jquery.html;341.1777615945572;348.4164025257693;353.08198683423103;354.67901549098065;355.93593153232416;12395.318257495845;14647.56057318281;15346.07923524588;15414.306356213969;16624.418145364885;15285.770713439308;15386.769198462032;15579;15658.295376708047;15933;4819.831305904286;4941.876453088684;5059.974700126512;5066.392032956051;5068.315777370045;4420.955790442103;4958.603311735071;4978.751062446881;4987.75061246938;4987.975060124694;4960.67755595887;4963.851084467472;4963.900721985558;4970.726610036447;4970.850874473772;4795.400574928134;5009.949900500985;5031.924521132186;5035.144025515671;5036.244563315496;4526.140033393677;4527.207738645724;4529.116822219668;4529.320601909707;4532.5694059064335;17648.735268970977;18640.347587834498;19578.21687132513;19627.80372196274;19680.457517646817;1823.188681036939;1839.7884243312058;1882.576420305434;1892.2241880828794;2222.988540214215;8896.243819275369;8959.41763785352;9199.770005749842;10903.34579925199;13239.404226809816;1628.080134723877;1714.6313542588402;1735.7222844344844;1753.7194048952233;1777.5822681669797;65640.67179664072;66317.33682663208;66390.3360966389;67678.3232167672;67736.6613166936;9615.855762163574;9688.224942004623;9845.753856153653;9939.254555908336;10171.288009839389;13208.537701180605;13307.733845323039;13425.462981480827;13448.731025379439;13472.05695601318;7164.82087947795;7293.270672932665;7296.635168241567;7492.737754178577;7526.736564220336;6942.201646810681;7007.089078419773;7171.462140339496;7174.569525828467;7200.279972002758;3931.5282166140246;3966.7421617594764;4228;4296.742195468282;4329.307310830315;1690.0873528294583;1698.8471037606428;1744.9563760906078;1774.6539424812295;1796.5059608607476;744.9515781474295;766.6013672890066;791.6951973490133;795.777182388932;826.499967519654;15735.763963540327;16309.755353669705;16488;17087.743683844754;17122.229499672296;748.3152915082748;749.6476655971685;757.4849102610278;823.4935514658562;825.9339252859756;8749.956250218707;8780.517071561126;9244.722658320261;9254.814903701888;9330.766730831649;405170;411573;415126;419276;419720;85354;87926.1207387918;88518;88596;88740;934.0892629686002;955.4744890310302;971.9805603887883;974.8537719342155;979.3927764785878;15685.294161762977;15922.203889805232;16716.247768850673;16728.832711672727;16861.66276674435;28314.575281370384;36026.63973360233;39544;40116.398254025626;40218;52014.47985520097;53083.4691653094;53741.73129134329;54579.72710136424;54777.45222547724;6937.410320122846;7095.219525852049;7134.607596582237;7216.278372162742;7359.632018399166;8095.352371810123;8573.61418736146;10132.240081994027;10782;10953.288036277616;9105.226055785333;9536.666216682383;9639.759006024906;9931.255155863195;10020.799584008424;9558.95220523893;9597.088276613711;9604.807903841744;10192.643257486248;10288.537015834456;9491.525423728648;9567.330286879851;9756.46339451337;10006.599736010477;10314.535845887103;7012.158540974911;7114.679839407343;7177.856442871218;7245.927540724525;7272.41820654357;8683.55688027819;9251.259899207913;9576.425414475154;9585.616575336908;9676.419414835133 15:15:27 INFO - PROCESS | 3018 | |3;mootools.html;1147.5123072694107;1155.8786327435619;1188.126726855761;1227.1164761371808;1330.5675655411994;7383.150937642173;7753.302202801747;7762.650680719367;7771.1063227728755;7984.600769961493;7827.452078354518;7927.326177274938;7934.9206507934905;7935.92064079359;7945.880811787828;1846.2061313635131;2089.19565967103;2176.748369687432;2206.9558608827815;2208.138825857917;2226.9665955010687;2254.2110261408457;2261.298997310839;2269.341890851651;2271.5229801741652;2168.2519530761942;2182.476205710634;2208.205046183373;2208.3706143749037;2211.3034394165866;2079.854410191287;2163.4158777130165;2172.424307558498;2180.1279488204686;2184.726909136358;2141.7108690326763;2158.6006588781124;2160.3302976077466;2161.9243326483656;2161.9351419457444;7890.960545197295;7931.444798864082;7952.244536768998;7960.562169080698;7963.6018199090395;4564.520725323827;4691.929621055687;4692.671512994092;4693.6479764017495;4697.436307643105;2891;2927.238917881345;3053.8473076346318;3056.144279601715;3065.800722953001;1016.8830584482805;1017.9134773544257;1023.846423036543;1036.9740756481074;1051.542578978147;10724.517396717167;10812.459377031117;10867.891321086767;10901.83647245292;10910.181736369805;4006.759594424344;4116.341385378325;4130.070734084807;4132.979335103305;4179.749215047107;8321.334293256525;8383.622736976851;8407.789805254917;8415.621297041647;8423.073461919184;4566;4570.245909424974;4570.314452832102;4573.771311434415;4574.679772415899;3584.390653588896;3967.940480892789;4061.4923134608175;4273.829046838154;4275.40144379787;3363.7140843028615;3366;3512.9121771955906;3516.1385460562324;3531.5938667053106;1037.3672060043368;1059.2638116508951;1062.2404980439023;1071.994640026795;1084.1001968366238;599.6372194822158;715.2997976779968;717.7631381644045;728.6648141854806;732.3043109046428;4613.284940834176;4657;4673.976630116896;4679.157751604744;4723.456802467692;360.80696827197323;363.1810267846043;367.29662695937515;367.94848721179056;371.36311226247113;3157.7947433416753;3167.5407065975305;3220.130564747505;3254.902352929416;3293.522439246296;9392.15470607635;9803.215742740564;9835.16401105914;9837.754056148653;9839.212862970946;9693.030696930251;9709.465979371202;9720.270979676552;9728.61085556584;9752.46361450127;7346.191918888918;7346.96326518364;7387.556746595222;7392.112946446353;7411.110666720028;4746.4541577719;4881.341018962395;4897.706137631753;4903.828366007316;4956.330895329084;8790.780230494289;8801.559922004002;9026.593803279;9082.727518174466;9101.544922753968;8986.101389861224;9057.094290571154;9161.725148245563;9198.862017069883;9289.535523223676;5621.381648018633;5719.685417302088;5954.136650185786;5984.401559843981;6031.215941927521;7300.56196628204;7336.596487193256;7384.150822655249;7395.852082958419;7400.555966642019;6317.873642527215;6520.217573891164;6610.6694665267505;6698.995150727235;6803.115594972622;6424.51816113784;6430.067640192053;6539.803805885831;6587.4071333578295;6630.237522684953;5964.194833697569;6069.666168360606;6070.605410648293;6084.239470066242;6088.208532890696;4244.278472659717;4248.95751042498;4292.18448494785;4368.716033457815;4381.430414046154;4243.3847092170845;4311.633511151587;4369.104333611665;4385.956140438555;4405.537418571004 15:15:27 INFO - PROCESS | 3018 | |4;prototype.html;285.7399766212747;298.96860829612905;299.1384811742183;299.9700029997;308.86409979608976;4905.583025442837;4938.580220681238;4939.813820086042;4949.505049495048;4970.975145124274;4836.492168322328;4885.413750349963;4889.119958407486;4889.804407823692;4895.926561101586;3833.5591406988133;3842.212346468981;3843.500344955152;3860.285847118285;3879.262940041383;3723.888283351504;3842.53889533255;3847.5571660627265;3848.942265866014;3853.7687738735626;3786.299534586097;3809.3904975203973;3834.923301533968;3851.133494963639;3862.2661694278;3818.6372294631965;3820.8662696805754;3826;3826.1199924017633;3848.749831260973;3172.7144556989983;3206.150370151912;3345.1469875181915;3367.579052618423;3386.865400090948;4702.764861756933;4705.882352941204;4715.575598196145;4717.481077081518;4745.905081898377;4363;4367.563243675639;4367.847125350598;4389.758563279019;4390.078083602447;4760.571828451485;4883.9011222474655;5036.622253331015;5095.439501654815;5125.436202017775;3659.323025240339;3671.7980511071883;3684.360459595481;3685.281370132825;3688.2992231475932;5310.36275646921;5317.441668624778;5318.175682769177;5323.387810401815;5389.568834493231;3552.378333791576;3724.2923844470006;3821.7515861468914;3822.7132965027736;3828.578856325802;3741.7886308727384;3749.2876353492748;3752.4934133891575;3764.228333191689;3786.981065094657;4296.613304802583;4300.65594752419;4306.913861722748;4313.547077556874;4317.784110794448;5076.644634875597;5106.617003724736;5112.437631860493;5118.61610379223;5131.204663277198;1234.4630085912656;1292.959167869855;1303.3678665847056;1308.7317099994477;1311.2984553263957;808.3008197908885;820.2781552233996;828.5484410996022;832.9583520823935;841.8190089130866;3978.462907507507;4007.358822588372;4010.6590939770444;4023.4166045923175;4041.434199212054;4632.559906808848;4636.721796692209;4639.420072490939;4648.674592778473;4651.232546629768;4006.1787333596544;4050.832804449605;4059.2693315203546;4069.4302797608357;4070.226656935232;2331.2311597652006;2474.888630011618;2481.8955564773864;2483.913063042785;2493.364192130995;4418.756968366771;4759.762011899391;4825.831095911626;4995.900081998339;5024.221245706921;5409.161579955114;5416.510459623635;5427.48438898304;5427.891442171134;5442.863928401822;4969.2546118081855;4975.477574854733;4977.303177555145;5014.799408023711;5015.598752099823;5061.291419201241;5179.974100129475;5228.738563071907;5235.947640523546;5243.265942768092;5147.819826306061;5160.690358578498;5163.225516172604;5171.974140129275;5188.351456067991;4744.430668319824;4949.277897156478;4973.5523802857915;4975.701457912537;4975.726335051607;3673.8714145004797;3690.3541880170324;3696.4085746280466;3699.5560532736245;3716.219593885314;5245;5253.159494480865;5255;5272.920906186334;5298.072837253542;5085.847424577269;5096.23556466533;5127.564282001045;5154.14956532168;5154.252633368065;4833.202521583899;5089;5141.691498510101;5166.3800343958965;5172.1465958118;5043.646944713835;5072.666573376288;5116.386033675983;5116.923246151385;5138.8972220556125;4849.927251091307;5190.740462976912;5236.423993360803;5245.449227831023;5277.182036784305;4981.227909674007;5013.323201367769;5015.699058056528;5023.296738456546;5035.237666816732 15:15:27 INFO - PROCESS | 3018 | |5;yui.html;543.6167501911153;572.0960881806745;584.5674201091189;598.0670154558887;607.2955371768746;12429.067819913509;13202.075854690176;13247.072704910635;13259.40332685029;13270.7345853083;11751.118666100034;11877.584284550043;11912.404379781019;11921.701957451047;12006.399680016008;712.8609921065395;727.0439372225533;729.7117638532803;729.9343059124677;730.5543618392776;588.0033343482799;710.2364957670499;738.9261073892594;744.9553026818409;747.805570551655;777.0170734021439;777.9688812447496;778.2334400615389;778.4861991085885;778.6301506784289;775.3796962430033;775.4959276470311;775.5385545600359;775.6393277126135;776.6116941529235;456.06051533840395;459.75632914555337;459.78619941726924;548.5858177076282;563.4478211352856;11524.711882203012;11557.653270401901;11563.612366515988;11581.710457238552;11594.47824847884;10703.625373111903;11156.330620162817;11201.495932682967;11356.091512679048;11855.46650400734;11306.265092769027;11333.433328333633;11389.658310250707;11389.829152562717;11489.310641361544;3865.845366185349;3884.2425726982965;3906.7655940643654;3917.2948869203533;3922.2155568886337;53703.462965370236;55215.447845521834;56607.433925660625;62382.688086559734;66026.66986665085;8678.56607169639;8938.46369217849;9072.228860546795;9120.407173533698;9348.532573371303;16242.58905629831;16399.18004099814;16400.589985250463;16415.753763693556;16583.6683266334;6804.965975170093;6845.110135682329;6860.142482189726;6860.759873404507;6940.618265995317;3610.151614370621;3640.9089772755365;3685.152414944524;3695.4641576971726;3761.774293542396;2626.2121363590845;2719.360950176707;2721.5781553859183;2725.591161325817;2727.6317697111035;482.0696056610775;483.74361588358227;483.84275110588493;490.4090570862103;497.0704782057575;470.2147413818931;494.110206340423;551.1402212548437;570.3811364669298;584.0480017571332;7035.155781306276;7354.70581176747;7704.460687751915;7742.58622153203;8193;499.6827014845599;512.7718165416428;542.6038991536201;567.8807450435372;573.0458786121145;3597.8380972856285;3737.7009839213342;3831.7126215533945;3839.6352346527037;3864.3430616795213;102217.48891255645;102435;105131;106899;107936.46031769791;48903.75548122237;55422.44577554173;84571.57714211513;87899.1210087891;87936.560317198;46409.76795116003;63934.68032659807;79780.98437242601;79784.20215797768;81286;7008.369246767611;7144.535605185646;7234.6744396501235;7279.636018199175;7546.471746977879;43781.78109109434;44140.77929610331;44471.777641111585;46543.06913861771;46609.53390466052;62057.379426206964;68876.65561672159;68895;69078;69182.65408672925;9103.863442048241;9379.624815007597;9403.153716165578;9438.480883551196;9600.855987160337;10197.54111064989;10204.4387558685;10317.74205644865;10997.835032474359;11232.3260604364;9738.659146930107;9828.26288028415;9897.604095836086;9904.158146557624;10533.735951685847;9515.619375224913;9690.030996900536;10643.414612196404;11354.489047993025;11673;10682.252242342962;10952.726181845517;10981.176411768989;12283.570075047688;12294;8933.28533717314;9066.22937050358;9590.760230994281;9942.15491683215;10454.790904182026;9295.814083718153;9775.315727899264;10226.233032522441;10233.897661023593;10344.172466202835 15:15:27 INFO - PROCESS | 3018 | __end_tp_report 15:15:27 INFO - PROCESS | 3018 | __start_cc_report 15:15:27 INFO - PROCESS | 3018 | _x_x_mozilla_cycle_collect,955 15:15:27 INFO - PROCESS | 3018 | __end_cc_report 15:15:27 INFO - PROCESS | 3018 | __startTimestamp1472854527435__endTimestamp 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | ------- Summary: start ------- 15:15:27 INFO - PROCESS | 3018 | Number of tests: 6 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#0] dojo.html Cycles:165 Average:4775.22 Median:4902.17 stddev:507.55 (10.4%) stddev-sans-first:479.82 15:15:27 INFO - PROCESS | 3018 | Values: 2609.4 2610.2 2616.6 2664.8 2674.2 4652.4 4731.6 4766.5 4818.0 4861.4 4777.2 4803.8 4862.4 4892.2 4908.6 4380.3 4394.9 4454.4 4517.9 4530.1 4500.2 4538.7 4552.5 4568.3 4584.4 4368.9 4371.8 4416.7 4433.9 4452.0 4457.1 4513.8 4524.8 4528.1 4529.0 4405.5 4405.6 4417.3 4427.5 4471.2 4670.6 4835.2 4849.9 4854.7 4883.2 5072.3 5116.4 5119.5 5123.4 5184.2 5154.9 5163.8 5164.1 5168.7 5172.4 4767.0 4784.8 4790.7 4798.0 4854.7 5254.1 5282.7 5328.2 5364.3 5373.6 5101.2 5103.2 5113.7 5155.8 5166.9 5129.7 5163.6 5165.6 5172.5 5242.6 5030.4 5057.3 5073.2 5117.1 5128.9 5064.9 5074.2 5083.7 5135.3 5152.7 4379.9 4384.2 4384.4 4398.7 4443.6 3798.1 3801.8 3801.9 3811.8 3832.5 4408.1 4420.4 4429.5 4474.2 4485.8 5117.8 5153.7 5163.6 5182.8 5236.3 4361.0 4373.4 4384.8 4431.4 4470.8 4649.8 4655.1 4670.1 4720.3 4733.8 4860.1 4870.6 4873.0 4876.0 4929.6 5081.8 5151.8 5153.3 5172.6 5228.6 4865.8 4874.6 4902.2 4948.3 4964.1 5135.8 5137.0 5143.3 5153.0 5212.6 5055.3 5157.7 5180.7 5198.4 5201.7 5051.3 5054.0 5062.9 5118.7 5127.3 5011.8 5041.6 5047.5 5054.9 5115.1 4853.0 4914.8 4940.2 4971.6 4972.4 5034.6 5064.8 5066.4 5115.1 5126.1 4898.6 4930.6 4942.0 4946.0 5005.1 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#1] ext.html Cycles:180 Average:43842.51 Median:18899.39 stddev:80600.11 (426.5%) stddev-sans-first:80760.60 15:15:27 INFO - PROCESS | 3018 | Values: 526.3 538.5 554.5 564.2 577.2 34925.5 36800.3 36860.4 36872.1 39779.8 36713.8 37073.1 37154.8 37186.4 37212.3 7441.7 7579.8 7586.0 7586.2 7619.4 7504.2 7567.2 7582.8 7583.4 7586.2 7601.0 7636.5 7636.9 7638.3 7639.0 7524.6 7561.1 7571.8 7592.6 7594.8 7339.8 7406.9 7417.2 7426.0 7433.1 34024.0 34199.7 34277.7 34288.8 34312.8 2666.7 2752.3 2828.8 2832.3 3096.1 25772.6 26026.2 26031.0 26613.9 27276.9 3366.2 3485.9 3524.5 3524.8 3570.8 242146.0 243210.0 243370.0 243490.0 243839.0 45108.5 45115.5 45174.0 45418.5 45847.8 46221.3 47855.8 48019.8 50382.0 51148.7 13262.1 13366.5 13367.2 13376.5 13407.3 8847.5 10505.5 10593.2 10606.1 10606.4 13267.0 13774.0 13804.3 14137.9 14169.8 5284.9 5375.6 5423.7 5490.5 5506.8 726.4 782.3 870.3 875.9 906.8 24376.4 25748.7 26014.3 26039.7 26084.5 896.9 911.1 925.0 936.2 985.2 13160.3 13395.1 13557.4 13559.9 13641.6 354394.0 356594.0 357510.0 357805.0 358328.0 42412.8 42586.0 42624.8 42652.4 42785.4 1033.2 1035.4 1040.7 1060.0 1066.0 24967.0 25698.2 26683.2 27167.0 27231.5 36131.3 36548.3 36620.3 36627.5 36671.3 306165.0 306322.0 307379.0 307510.0 308336.0 20013.0 20850.5 20882.9 20886.6 22269.0 33735.8 36783.4 36957.6 37781.6 37855.2 31838.8 32168.5 32260.5 32452.5 32766.0 31805.7 32215.7 32255.5 32319.0 33393.5 31876.0 31995.2 32408.7 32540.3 32896.7 27883.1 29567.7 29819.3 29851.3 30115.5 23150.6 23281.9 23442.5 23443.4 23520.8 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#2] jquery.html Cycles:180 Average:24947.35 Median:4974.80 stddev:68555.27 (1378.1%) stddev-sans-first:68722.69 15:15:27 INFO - PROCESS | 3018 | Values: 341.2 348.4 353.1 354.7 355.9 12395.3 14647.6 15346.1 15414.3 16624.4 15285.8 15386.8 15579.0 15658.3 15933.0 4819.8 4941.9 5060.0 5066.4 5068.3 4421.0 4958.6 4978.8 4987.8 4988.0 4960.7 4963.9 4963.9 4970.7 4970.9 4795.4 5009.9 5031.9 5035.1 5036.2 4526.1 4527.2 4529.1 4529.3 4532.6 17648.7 18640.3 19578.2 19627.8 19680.5 1823.2 1839.8 1882.6 1892.2 2223.0 8896.2 8959.4 9199.8 10903.3 13239.4 1628.1 1714.6 1735.7 1753.7 1777.6 65640.7 66317.3 66390.3 67678.3 67736.7 9615.9 9688.2 9845.8 9939.3 10171.3 13208.5 13307.7 13425.5 13448.7 13472.1 7164.8 7293.3 7296.6 7492.7 7526.7 6942.2 7007.1 7171.5 7174.6 7200.3 3931.5 3966.7 4228.0 4296.7 4329.3 1690.1 1698.8 1745.0 1774.7 1796.5 745.0 766.6 791.7 795.8 826.5 15735.8 16309.8 16488.0 17087.7 17122.2 748.3 749.6 757.5 823.5 825.9 8750.0 8780.5 9244.7 9254.8 9330.8 405170.0 411573.0 415126.0 419276.0 419720.0 85354.0 87926.1 88518.0 88596.0 88740.0 934.1 955.5 972.0 974.9 979.4 15685.3 15922.2 16716.2 16728.8 16861.7 28314.6 36026.6 39544.0 40116.4 40218.0 52014.5 53083.5 53741.7 54579.7 54777.5 6937.4 7095.2 7134.6 7216.3 7359.6 8095.4 8573.6 10132.2 10782.0 10953.3 9105.2 9536.7 9639.8 9931.3 10020.8 9559.0 9597.1 9604.8 10192.6 10288.5 9491.5 9567.3 9756.5 10006.6 10314.5 7012.2 7114.7 7177.9 7245.9 7272.4 8683.6 9251.3 9576.4 9585.6 9676.4 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#3] mootools.html Cycles:180 Average:5017.94 Median:4593.98 stddev:2914.96 (63.5%) stddev-sans-first:2908.62 15:15:27 INFO - PROCESS | 3018 | Values: 1147.5 1155.9 1188.1 1227.1 1330.6 7383.2 7753.3 7762.7 7771.1 7984.6 7827.5 7927.3 7934.9 7935.9 7945.9 1846.2 2089.2 2176.7 2207.0 2208.1 2227.0 2254.2 2261.3 2269.3 2271.5 2168.3 2182.5 2208.2 2208.4 2211.3 2079.9 2163.4 2172.4 2180.1 2184.7 2141.7 2158.6 2160.3 2161.9 2161.9 7891.0 7931.4 7952.2 7960.6 7963.6 4564.5 4691.9 4692.7 4693.6 4697.4 2891.0 2927.2 3053.8 3056.1 3065.8 1016.9 1017.9 1023.8 1037.0 1051.5 10724.5 10812.5 10867.9 10901.8 10910.2 4006.8 4116.3 4130.1 4133.0 4179.7 8321.3 8383.6 8407.8 8415.6 8423.1 4566.0 4570.2 4570.3 4573.8 4574.7 3584.4 3967.9 4061.5 4273.8 4275.4 3363.7 3366.0 3512.9 3516.1 3531.6 1037.4 1059.3 1062.2 1072.0 1084.1 599.6 715.3 717.8 728.7 732.3 4613.3 4657.0 4674.0 4679.2 4723.5 360.8 363.2 367.3 367.9 371.4 3157.8 3167.5 3220.1 3254.9 3293.5 9392.2 9803.2 9835.2 9837.8 9839.2 9693.0 9709.5 9720.3 9728.6 9752.5 7346.2 7347.0 7387.6 7392.1 7411.1 4746.5 4881.3 4897.7 4903.8 4956.3 8790.8 8801.6 9026.6 9082.7 9101.5 8986.1 9057.1 9161.7 9198.9 9289.5 5621.4 5719.7 5954.1 5984.4 6031.2 7300.6 7336.6 7384.2 7395.9 7400.6 6317.9 6520.2 6610.7 6699.0 6803.1 6424.5 6430.1 6539.8 6587.4 6630.2 5964.2 6069.7 6070.6 6084.2 6088.2 4244.3 4249.0 4292.2 4368.7 4381.4 4243.4 4311.6 4369.1 4386.0 4405.5 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#4] prototype.html Cycles:180 Average:4193.48 Median:4745.17 stddev:1238.65 (26.1%) stddev-sans-first:1206.90 15:15:27 INFO - PROCESS | 3018 | Values: 285.7 299.0 299.1 300.0 308.9 4905.6 4938.6 4939.8 4949.5 4971.0 4836.5 4885.4 4889.1 4889.8 4895.9 3833.6 3842.2 3843.5 3860.3 3879.3 3723.9 3842.5 3847.6 3848.9 3853.8 3786.3 3809.4 3834.9 3851.1 3862.3 3818.6 3820.9 3826.0 3826.1 3848.7 3172.7 3206.2 3345.1 3367.6 3386.9 4702.8 4705.9 4715.6 4717.5 4745.9 4363.0 4367.6 4367.8 4389.8 4390.1 4760.6 4883.9 5036.6 5095.4 5125.4 3659.3 3671.8 3684.4 3685.3 3688.3 5310.4 5317.4 5318.2 5323.4 5389.6 3552.4 3724.3 3821.8 3822.7 3828.6 3741.8 3749.3 3752.5 3764.2 3787.0 4296.6 4300.7 4306.9 4313.5 4317.8 5076.6 5106.6 5112.4 5118.6 5131.2 1234.5 1293.0 1303.4 1308.7 1311.3 808.3 820.3 828.5 833.0 841.8 3978.5 4007.4 4010.7 4023.4 4041.4 4632.6 4636.7 4639.4 4648.7 4651.2 4006.2 4050.8 4059.3 4069.4 4070.2 2331.2 2474.9 2481.9 2483.9 2493.4 4418.8 4759.8 4825.8 4995.9 5024.2 5409.2 5416.5 5427.5 5427.9 5442.9 4969.3 4975.5 4977.3 5014.8 5015.6 5061.3 5180.0 5228.7 5235.9 5243.3 5147.8 5160.7 5163.2 5172.0 5188.4 4744.4 4949.3 4973.6 4975.7 4975.7 3673.9 3690.4 3696.4 3699.6 3716.2 5245.0 5253.2 5255.0 5272.9 5298.1 5085.8 5096.2 5127.6 5154.1 5154.3 4833.2 5089.0 5141.7 5166.4 5172.1 5043.6 5072.7 5116.4 5116.9 5138.9 4849.9 5190.7 5236.4 5245.4 5277.2 4981.2 5013.3 5015.7 5023.3 5035.2 15:15:27 INFO - PROCESS | 3018 | 15:15:27 INFO - PROCESS | 3018 | [#5] yui.html Cycles:180 Average:17143.75 Median:506.23 stddev:25489.46 (5035.2%) stddev-sans-first:25530.49 15:15:27 INFO - PROCESS | 3018 | Values: 543.6 572.1 584.6 598.1 607.3 12429.1 13202.1 13247.1 13259.4 13270.7 11751.1 11877.6 11912.4 11921.7 12006.4 712.9 727.0 729.7 729.9 730.6 588.0 710.2 738.9 745.0 747.8 777.0 778.0 778.2 778.5 778.6 775.4 775.5 775.5 775.6 776.6 456.1 459.8 459.8 548.6 563.4 11524.7 11557.7 11563.6 11581.7 11594.5 10703.6 11156.3 11201.5 11356.1 11855.5 11306.3 11333.4 11389.7 11389.8 11489.3 3865.8 3884.2 3906.8 3917.3 3922.2 53703.5 55215.4 56607.4 62382.7 66026.7 8678.6 8938.5 9072.2 9120.4 9348.5 16242.6 16399.2 16400.6 16415.8 16583.7 6805.0 6845.1 6860.1 6860.8 6940.6 3610.2 3640.9 3685.2 3695.5 3761.8 2626.2 2719.4 2721.6 2725.6 2727.6 482.1 483.7 483.8 490.4 497.1 470.2 494.1 551.1 570.4 584.0 7035.2 7354.7 7704.5 7742.6 8193.0 499.7 512.8 542.6 567.9 573.0 3597.8 3737.7 3831.7 3839.6 3864.3 102217.5 102435.0 105131.0 106899.0 107936.5 48903.8 55422.4 84571.6 87899.1 87936.6 46409.8 63934.7 79781.0 79784.2 81286.0 7008.4 7144.5 7234.7 7279.6 7546.5 43781.8 44140.8 44471.8 46543.1 46609.5 62057.4 68876.7 68895.0 69078.0 69182.7 9103.9 9379.6 9403.2 9438.5 9600.9 10197.5 10204.4 10317.7 10997.8 11232.3 9738.7 9828.3 9897.6 9904.2 10533.7 9515.6 9690.0 10643.4 11354.5 11673.0 10682.3 10952.7 10981.2 12283.6 12294.0 8933.3 9066.2 9590.8 9942.2 10454.8 9295.8 9775.3 10226.2 10233.9 10344.2 15:15:27 INFO - PROCESS | 3018 | -------- Summary: end -------- 15:15:27 INFO - PROCESS | 3018 | 15:15:28 INFO - TEST-INFO | 3018: exit 0 15:15:28 INFO - TEST-OK | dromaeo_css | took 1120886ms 15:15:28 INFO - TEST-START | kraken 15:15:28 INFO - operating with platform_type : linux_ 15:15:28 INFO - Initialising browser for kraken test... 15:15:28 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyci_lZ/profile http://localhost:53303/getInfo.html) 15:15:32 INFO - PROCESS | 3326 | __metrics Screen width/height:1600/1200 15:15:32 INFO - PROCESS | 3326 | colorDepth:24 15:15:32 INFO - PROCESS | 3326 | Browser inner width/height: 1024/697 15:15:32 INFO - PROCESS | 3326 | __metrics 15:15:32 INFO - PROCESS | 3326 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:15:32 INFO - PROCESS | 3326 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:15:33 INFO - PROCESS | 3326 | console.error: PushService: 15:15:33 INFO - PROCESS | 3326 | stateChangeProcessEnqueue: Error transitioning state 15:15:33 INFO - PROCESS | 3326 | UnknownError 15:15:34 INFO - TEST-INFO | 3326: exit 0 15:15:34 INFO - Browser initialized. 15:15:34 INFO - Running cycle 1/1 for kraken test... 15:15:34 INFO - TEST-INFO | started process 3407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyci_lZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:46 INFO - PROCESS | 3407 | RSS: Main: 180490240 15:15:46 INFO - PROCESS | 3407 | 15:15:49 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53303/tests/kraken/driver.html?testName=audio-beat-detection) 15:15:49 INFO - PROCESS | 3407 | RSS: Main: 235061248 15:15:49 INFO - PROCESS | 3407 | 15:15:52 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53303/tests/kraken/driver.html?testName=audio-dft) 15:15:53 INFO - PROCESS | 3407 | RSS: Main: 224673792 15:15:53 INFO - PROCESS | 3407 | 15:15:56 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53303/tests/kraken/driver.html?testName=audio-fft) 15:15:57 INFO - PROCESS | 3407 | RSS: Main: 303833088 15:15:57 INFO - PROCESS | 3407 | 15:15:59 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53303/tests/kraken/driver.html?testName=audio-oscillator) 15:15:59 INFO - PROCESS | 3407 | RSS: Main: 213516288 15:15:59 INFO - PROCESS | 3407 | 15:16:02 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:16:02 INFO - PROCESS | 3407 | RSS: Main: 214937600 15:16:02 INFO - PROCESS | 3407 | 15:16:05 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53303/tests/kraken/driver.html?testName=imaging-darkroom) 15:16:06 INFO - PROCESS | 3407 | RSS: Main: 253448192 15:16:06 INFO - PROCESS | 3407 | 15:16:10 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53303/tests/kraken/driver.html?testName=imaging-desaturate) 15:16:10 INFO - PROCESS | 3407 | RSS: Main: 247345152 15:16:10 INFO - PROCESS | 3407 | 15:16:13 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53303/tests/kraken/driver.html?testName=json-parse-financial) 15:16:14 INFO - PROCESS | 3407 | RSS: Main: 251035648 15:16:14 INFO - PROCESS | 3407 | 15:16:15 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:16:16 INFO - PROCESS | 3407 | RSS: Main: 214355968 15:16:16 INFO - PROCESS | 3407 | 15:16:18 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:16:19 INFO - PROCESS | 3407 | RSS: Main: 221659136 15:16:19 INFO - PROCESS | 3407 | 15:16:21 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:16:22 INFO - PROCESS | 3407 | RSS: Main: 222482432 15:16:22 INFO - PROCESS | 3407 | 15:16:24 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:16:25 INFO - PROCESS | 3407 | RSS: Main: 223076352 15:16:25 INFO - PROCESS | 3407 | 15:16:28 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:16:29 INFO - PROCESS | 3407 | RSS: Main: 221810688 15:16:29 INFO - PROCESS | 3407 | 15:16:30 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:53303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53303/tests/kraken/driver.html?testName=ai-astar) 15:16:31 INFO - PROCESS | 3407 | RSS: Main: 272175104 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | __start_tp_report 15:16:31 INFO - PROCESS | 3407 | _x_x_mozilla_page_load 15:16:31 INFO - PROCESS | 3407 | _x_x_mozilla_page_load_details 15:16:31 INFO - PROCESS | 3407 | |i|pagename|runs| 15:16:31 INFO - PROCESS | 3407 | |0;ai-astar;113;114;119;114;116;115;113;117;117;133 15:16:31 INFO - PROCESS | 3407 | |1;audio-beat-detection;152;133;155;195;122;159;153;125;187;127 15:16:31 INFO - PROCESS | 3407 | |2;audio-dft;162;162;161;163;165;161;162;161;161;164 15:16:31 INFO - PROCESS | 3407 | |3;audio-fft;77;76;76;167;77;78;76;77;159;76 15:16:31 INFO - PROCESS | 3407 | |4;audio-oscillator;84;85;140;84;83;83;149;83;83;149 15:16:31 INFO - PROCESS | 3407 | |5;imaging-gaussian-blur;118;117;118;117;118;118;117;117;119;118 15:16:31 INFO - PROCESS | 3407 | |6;imaging-darkroom;148;148;148;148;147;148;149;148;147;148 15:16:31 INFO - PROCESS | 3407 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 15:16:31 INFO - PROCESS | 3407 | |8;json-parse-financial;64;64;65;63;65;66;65;64;64;76 15:16:31 INFO - PROCESS | 3407 | |9;json-stringify-tinderbox;66;67;66;67;67;66;66;67;67;67 15:16:31 INFO - PROCESS | 3407 | |10;stanford-crypto-aes;82;81;81;90;82;86;82;81;81;82 15:16:31 INFO - PROCESS | 3407 | |11;stanford-crypto-ccm;135;137;131;134;144;133;141;134;176;132 15:16:31 INFO - PROCESS | 3407 | |12;stanford-crypto-pbkdf2;177;179;174;176;173;180;172;177;173;175 15:16:31 INFO - PROCESS | 3407 | |13;stanford-crypto-sha256-iterative;71;73;70;69;70;70;69;69;69;69 15:16:31 INFO - PROCESS | 3407 | __end_tp_report 15:16:31 INFO - PROCESS | 3407 | __start_cc_report 15:16:31 INFO - PROCESS | 3407 | _x_x_mozilla_cycle_collect,1954 15:16:31 INFO - PROCESS | 3407 | __end_cc_report 15:16:31 INFO - PROCESS | 3407 | __startTimestamp1472854591089__endTimestamp 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | ------- Summary: start ------- 15:16:31 INFO - PROCESS | 3407 | Number of tests: 14 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#0] ai-astar Cycles:10 Average:117.10 Median:116.50 stddev:5.92 (5.1%) stddev-sans-first:6.09 15:16:31 INFO - PROCESS | 3407 | Values: 113.0 114.0 119.0 114.0 116.0 115.0 113.0 117.0 117.0 133.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.00 stddev:25.24 (16.4%) stddev-sans-first:26.77 15:16:31 INFO - PROCESS | 3407 | Values: 152.0 133.0 155.0 195.0 122.0 159.0 153.0 125.0 187.0 127.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 15:16:31 INFO - PROCESS | 3407 | Values: 162.0 162.0 161.0 163.0 165.0 161.0 162.0 161.0 161.0 164.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:36.47 (47.7%) stddev-sans-first:38.17 15:16:31 INFO - PROCESS | 3407 | Values: 77.0 76.0 76.0 167.0 77.0 78.0 76.0 77.0 159.0 76.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.00 stddev:30.26 (36.5%) stddev-sans-first:31.36 15:16:31 INFO - PROCESS | 3407 | Values: 84.0 85.0 140.0 84.0 83.0 83.0 149.0 83.0 83.0 149.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:16:31 INFO - PROCESS | 3407 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 119.0 118.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:16:31 INFO - PROCESS | 3407 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 149.0 148.0 147.0 148.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 15:16:31 INFO - PROCESS | 3407 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.75 (5.8%) stddev-sans-first:3.93 15:16:31 INFO - PROCESS | 3407 | Values: 64.0 64.0 65.0 63.0 65.0 66.0 65.0 64.0 64.0 76.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 15:16:31 INFO - PROCESS | 3407 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 67.0 67.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.94 (3.6%) stddev-sans-first:3.10 15:16:31 INFO - PROCESS | 3407 | Values: 82.0 81.0 81.0 90.0 82.0 86.0 82.0 81.0 81.0 82.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:136.00 stddev:13.38 (9.8%) stddev-sans-first:14.09 15:16:31 INFO - PROCESS | 3407 | Values: 135.0 137.0 131.0 134.0 144.0 133.0 141.0 134.0 176.0 132.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.50 stddev:2.67 (1.5%) stddev-sans-first:2.79 15:16:31 INFO - PROCESS | 3407 | Values: 177.0 179.0 174.0 176.0 173.0 180.0 172.0 177.0 173.0 175.0 15:16:31 INFO - PROCESS | 3407 | 15:16:31 INFO - PROCESS | 3407 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.29 (1.8%) stddev-sans-first:1.30 15:16:31 INFO - PROCESS | 3407 | Values: 71.0 73.0 70.0 69.0 70.0 70.0 69.0 69.0 69.0 69.0 15:16:31 INFO - PROCESS | 3407 | -------- Summary: end -------- 15:16:31 INFO - PROCESS | 3407 | 15:16:32 INFO - TEST-INFO | 3407: exit 0 15:16:32 INFO - TEST-OK | kraken | took 64043ms 15:16:32 INFO - SUITE-END | took 1184s 15:16:32 INFO - Completed test suite (00:19:45) 15:16:32 INFO - javascript benchmark 15:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.412882101527, 2610.2038878142166, 2616.620590014447, 2664.7868170546344, 2674.197740677796, 4652.371929789478, 4731.621470282378, 4766.475687674358, 4818.036392721457, 4861.368022157119, 4777.235642297233, 4803.831865884695, 4862.3922009748785, 4892.241702536104, 4908.582770464514, 4380.342948557726, 4394.8901277468, 4454.443194600675, 4517.934317181489, 4530.093981203756, 4500.167469018242, 4538.659600529957, 4552.521985191557, 4568.291914753218, 4584.381108550353, 4368.868933931987, 4371.7540500957075, 4416.734995900256, 4433.866983990453, 4451.9777401113115, 4457.086297309076, 4513.7517436540975, 4524.773761311922, 4528.139653465831, 4528.977355113203, 4405.5016407177245, 4405.581469760367, 4417.315316126005, 4427.512973572904, 4471.150481408522, 4670.602998745111, 4835.226363781778, 4849.927251091236, 4854.708717476963, 4883.19427294496, 5072.34059572257, 5116.437191908887, 5119.488051194888, 5123.410807757118, 5184.170532714786, 5154.871128221787, 5163.7676304566385, 5164.070467315882, 5168.715720635363, 5172.353455818023, 4766.976165119152, 4784.832530861403, 4790.688605240648, 4797.976010119927, 4854.708717476892, 5254.133068043807, 5282.683039017671, 5328.200769884548, 5364.329458817648, 5373.623846330719, 5101.20931255656, 5103.209002604603, 5113.744312784346, 5155.819546315861, 5166.870828229325, 5129.743512824344, 5163.561097306696, 5165.586753059746, 5172.456892026358, 5242.606804489678, 5030.37120359955, 5057.317262169634, 5073.188289873602, 5117.053345131163, 5128.948710512922, 5064.873378165576, 5074.188129899198, 5083.669561478492, 5135.255387968724, 5152.665076770073, 4379.890502737457, 4384.167008268419, 4384.4081049058605, 4398.714083584621, 4443.577860103285, 3798.1264309209037, 3801.7718936863876, 3801.9354580717445, 3811.8094095295123, 3832.5017747692623, 4408.140412619572, 4420.425344705168, 4429.49060857999, 4474.172278128557, 4485.775711214426, 5117.795288188431, 5153.665011774223, 5163.561097306696, 5182.792688292426, 5236.345456817898, 4361.0, 4373.409589705413, 4384.824607015684, 4431.446069241345, 4470.798814053375, 4649.837255696035, 4655.068986202706, 4670.065986802653, 4720.268358404453, 4733.786979585927, 4860.1251774680895, 4870.561649451566, 4873.0, 4875.975620121877, 4929.605631549539, 5081.7713202905215, 5151.768170432414, 5153.330067091254, 5172.612054095883, 5228.555572776357, 4865.756712164307, 4874.610031197567, 4902.166631672696, 4948.282499037691, 4964.131277026579, 5135.794568217229, 5137.049645815536, 5143.305653736697, 5153.0466863630345, 5212.582993360446, 5055.342805435417, 5157.6647517911215, 5180.6891586504935, 5198.37619485649, 5201.7399130044105, 5051.3433253676785, 5053.974730126326, 5062.949370506248, 5118.74406279692, 5127.282180494659, 5011.824586139468, 5041.571466425395, 5047.545720885138, 5054.898902022012, 5115.079285728456, 4852.95147048525, 4914.827981020647, 4940.2342636891335, 4971.552560269449, 4972.378452693413, 5034.622403319692, 5064.8480545582215, 5066.392032956069, 5115.130427827204, 5126.077306084941, 4898.559129678346, 4930.580900623487, 4941.975290123526, 4946.0, 5005.149124648746], "value": 4741.762269152565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.3473293116535, 538.5368583018604, 554.5369616370331, 564.2072887592933, 577.1659951370269, 34925.47611785822, 36800.26399472009, 36860.44709329356, 36872.07819804503, 39779.801100994526, 36713.816430917876, 37073.073173170684, 37154.8142259289, 37186.44220336697, 37212.255754884885, 7441.702331906731, 7579.772606821804, 7585.962070189641, 7586.241375862425, 7619.42854285928, 7504.174540800507, 7567.243275672444, 7582.772516824504, 7583.355414789722, 7586.241375862425, 7601.0, 7636.465447418683, 7636.885446718304, 7638.274363935418, 7638.9618051909665, 7524.623768811538, 7561.092668879714, 7571.848563028763, 7592.620368981528, 7594.772156835304, 7339.816504587375, 7406.925930740677, 7417.184109747924, 7425.9628701856145, 7433.1080270367365, 34024.0, 34199.6580034199, 34277.6572234277, 34288.82855585731, 34312.82843585791, 2666.679998400185, 2752.3119220194953, 2828.830270183775, 2832.306085009186, 3096.1330827368374, 25772.613410798855, 26026.21921342363, 26031.0, 26613.866930665416, 27276.863615681992, 3366.1921138926728, 3485.9477107843404, 3524.4537096750046, 3524.7503094720737, 3570.7500474966764, 242146.0, 243210.0, 243370.0, 243490.0, 243839.0, 45108.54891451044, 45115.54884451179, 45174.0, 45418.54581454209, 45847.77076114598, 46221.30668039982, 47855.76072119617, 48019.75990120027, 50382.0, 51148.74425627848, 13262.071654984058, 13366.53217137415, 13367.197968121944, 13376.531821386205, 13407.262600557064, 8847.46915185091, 10505.474726263656, 10593.152547796159, 10606.098481628993, 10606.416647084485, 13267.0, 13774.0, 13804.309784510735, 14137.929310353587, 14169.78745318821, 5284.894302114013, 5375.596830237748, 5423.728813559306, 5490.505854473036, 5506.752196151183, 726.4370113162341, 782.2529484342439, 870.3037569944146, 875.8992715837633, 906.8322360363354, 24376.39059023503, 25748.742512574634, 26014.34964125874, 26039.73960260373, 26084.478310434064, 896.8699538567001, 911.1162172692477, 924.9953750231206, 936.2229349639782, 985.2364417576435, 13160.276184809927, 13395.12931659439, 13557.389917453738, 13559.86440135586, 13641.590752277447, 354394.0, 356594.0, 357510.0, 357805.0, 358328.0, 42412.78793606012, 42586.0, 42624.786876065424, 42652.3602145968, 42785.35821962673, 1033.2302434685907, 1035.4460363705382, 1040.7138037039874, 1060.0, 1066.0192622787054, 24967.006598679975, 25698.229053128434, 26683.16536466138, 27167.0, 27231.45537089287, 36131.27737445289, 36548.26903461969, 36620.26759464849, 36627.45058824067, 36671.266574668894, 306165.0, 306322.0, 307379.0, 307510.0, 308336.0, 20013.0, 20850.478738031063, 20882.895585521976, 20886.582268354243, 22269.0, 33735.83132084324, 36783.44824827576, 36957.646169454165, 37781.62218377891, 37855.24289514139, 31838.840805795822, 32168.517472238404, 32260.516092259106, 32452.513212302307, 32766.0, 31805.681943181196, 32215.677843221267, 32255.516167257978, 32319.0, 33393.49909751307, 31876.0, 31995.200119996254, 32408.675913240564, 32540.349193016482, 32896.67103329032, 27883.094395736418, 29567.704322957357, 29819.254518637208, 29851.253718657208, 30115.548266776455, 23150.57091450993, 23281.88359058194, 23442.531149377257, 23443.41391465227, 23520.764792351856], "value": 15965.694073662795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1777615945572, 348.4164025257693, 353.08198683423103, 354.67901549098065, 355.93593153232416, 12395.318257495845, 14647.56057318281, 15346.07923524588, 15414.306356213969, 16624.418145364885, 15285.770713439308, 15386.769198462032, 15579.0, 15658.295376708047, 15933.0, 4819.831305904286, 4941.876453088684, 5059.974700126512, 5066.392032956051, 5068.315777370045, 4420.955790442103, 4958.603311735071, 4978.751062446881, 4987.75061246938, 4987.975060124694, 4960.67755595887, 4963.851084467472, 4963.900721985558, 4970.726610036447, 4970.850874473772, 4795.400574928134, 5009.949900500985, 5031.924521132186, 5035.144025515671, 5036.244563315496, 4526.140033393677, 4527.207738645724, 4529.116822219668, 4529.320601909707, 4532.5694059064335, 17648.735268970977, 18640.347587834498, 19578.21687132513, 19627.80372196274, 19680.457517646817, 1823.188681036939, 1839.7884243312058, 1882.576420305434, 1892.2241880828794, 2222.988540214215, 8896.243819275369, 8959.41763785352, 9199.770005749842, 10903.34579925199, 13239.404226809816, 1628.080134723877, 1714.6313542588402, 1735.7222844344844, 1753.7194048952233, 1777.5822681669797, 65640.67179664072, 66317.33682663208, 66390.3360966389, 67678.3232167672, 67736.6613166936, 9615.855762163574, 9688.224942004623, 9845.753856153653, 9939.254555908336, 10171.288009839389, 13208.537701180605, 13307.733845323039, 13425.462981480827, 13448.731025379439, 13472.05695601318, 7164.82087947795, 7293.270672932665, 7296.635168241567, 7492.737754178577, 7526.736564220336, 6942.201646810681, 7007.089078419773, 7171.462140339496, 7174.569525828467, 7200.279972002758, 3931.5282166140246, 3966.7421617594764, 4228.0, 4296.742195468282, 4329.307310830315, 1690.0873528294583, 1698.8471037606428, 1744.9563760906078, 1774.6539424812295, 1796.5059608607476, 744.9515781474295, 766.6013672890066, 791.6951973490133, 795.777182388932, 826.499967519654, 15735.763963540327, 16309.755353669705, 16488.0, 17087.743683844754, 17122.229499672296, 748.3152915082748, 749.6476655971685, 757.4849102610278, 823.4935514658562, 825.9339252859756, 8749.956250218707, 8780.517071561126, 9244.722658320261, 9254.814903701888, 9330.766730831649, 405170.0, 411573.0, 415126.0, 419276.0, 419720.0, 85354.0, 87926.1207387918, 88518.0, 88596.0, 88740.0, 934.0892629686002, 955.4744890310302, 971.9805603887883, 974.8537719342155, 979.3927764785878, 15685.294161762977, 15922.203889805232, 16716.247768850673, 16728.832711672727, 16861.66276674435, 28314.575281370384, 36026.63973360233, 39544.0, 40116.398254025626, 40218.0, 52014.47985520097, 53083.4691653094, 53741.73129134329, 54579.72710136424, 54777.45222547724, 6937.410320122846, 7095.219525852049, 7134.607596582237, 7216.278372162742, 7359.632018399166, 8095.352371810123, 8573.61418736146, 10132.240081994027, 10782.0, 10953.288036277616, 9105.226055785333, 9536.666216682383, 9639.759006024906, 9931.255155863195, 10020.799584008424, 9558.95220523893, 9597.088276613711, 9604.807903841744, 10192.643257486248, 10288.537015834456, 9491.525423728648, 9567.330286879851, 9756.46339451337, 10006.599736010477, 10314.535845887103, 7012.158540974911, 7114.679839407343, 7177.856442871218, 7245.927540724525, 7272.41820654357, 8683.55688027819, 9251.259899207913, 9576.425414475154, 9585.616575336908, 9676.419414835133], "value": 7911.297811341995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1147.5123072694107, 1155.8786327435619, 1188.126726855761, 1227.1164761371808, 1330.5675655411994, 7383.150937642173, 7753.302202801747, 7762.650680719367, 7771.1063227728755, 7984.600769961493, 7827.452078354518, 7927.326177274938, 7934.9206507934905, 7935.92064079359, 7945.880811787828, 1846.2061313635131, 2089.19565967103, 2176.748369687432, 2206.9558608827815, 2208.138825857917, 2226.9665955010687, 2254.2110261408457, 2261.298997310839, 2269.341890851651, 2271.5229801741652, 2168.2519530761942, 2182.476205710634, 2208.205046183373, 2208.3706143749037, 2211.3034394165866, 2079.854410191287, 2163.4158777130165, 2172.424307558498, 2180.1279488204686, 2184.726909136358, 2141.7108690326763, 2158.6006588781124, 2160.3302976077466, 2161.9243326483656, 2161.9351419457444, 7890.960545197295, 7931.444798864082, 7952.244536768998, 7960.562169080698, 7963.6018199090395, 4564.520725323827, 4691.929621055687, 4692.671512994092, 4693.6479764017495, 4697.436307643105, 2891.0, 2927.238917881345, 3053.8473076346318, 3056.144279601715, 3065.800722953001, 1016.8830584482805, 1017.9134773544257, 1023.846423036543, 1036.9740756481074, 1051.542578978147, 10724.517396717167, 10812.459377031117, 10867.891321086767, 10901.83647245292, 10910.181736369805, 4006.759594424344, 4116.341385378325, 4130.070734084807, 4132.979335103305, 4179.749215047107, 8321.334293256525, 8383.622736976851, 8407.789805254917, 8415.621297041647, 8423.073461919184, 4566.0, 4570.245909424974, 4570.314452832102, 4573.771311434415, 4574.679772415899, 3584.390653588896, 3967.940480892789, 4061.4923134608175, 4273.829046838154, 4275.40144379787, 3363.7140843028615, 3366.0, 3512.9121771955906, 3516.1385460562324, 3531.5938667053106, 1037.3672060043368, 1059.2638116508951, 1062.2404980439023, 1071.994640026795, 1084.1001968366238, 599.6372194822158, 715.2997976779968, 717.7631381644045, 728.6648141854806, 732.3043109046428, 4613.284940834176, 4657.0, 4673.976630116896, 4679.157751604744, 4723.456802467692, 360.80696827197323, 363.1810267846043, 367.29662695937515, 367.94848721179056, 371.36311226247113, 3157.7947433416753, 3167.5407065975305, 3220.130564747505, 3254.902352929416, 3293.522439246296, 9392.15470607635, 9803.215742740564, 9835.16401105914, 9837.754056148653, 9839.212862970946, 9693.030696930251, 9709.465979371202, 9720.270979676552, 9728.61085556584, 9752.46361450127, 7346.191918888918, 7346.96326518364, 7387.556746595222, 7392.112946446353, 7411.110666720028, 4746.4541577719, 4881.341018962395, 4897.706137631753, 4903.828366007316, 4956.330895329084, 8790.780230494289, 8801.559922004002, 9026.593803279, 9082.727518174466, 9101.544922753968, 8986.101389861224, 9057.094290571154, 9161.725148245563, 9198.862017069883, 9289.535523223676, 5621.381648018633, 5719.685417302088, 5954.136650185786, 5984.401559843981, 6031.215941927521, 7300.56196628204, 7336.596487193256, 7384.150822655249, 7395.852082958419, 7400.555966642019, 6317.873642527215, 6520.217573891164, 6610.6694665267505, 6698.995150727235, 6803.115594972622, 6424.51816113784, 6430.067640192053, 6539.803805885831, 6587.4071333578295, 6630.237522684953, 5964.194833697569, 6069.666168360606, 6070.605410648293, 6084.239470066242, 6088.208532890696, 4244.278472659717, 4248.95751042498, 4292.18448494785, 4368.716033457815, 4381.430414046154, 4243.3847092170845, 4311.633511151587, 4369.104333611665, 4385.956140438555, 4405.537418571004], "value": 3923.6667287541813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7399766212747, 298.96860829612905, 299.1384811742183, 299.9700029997, 308.86409979608976, 4905.583025442837, 4938.580220681238, 4939.813820086042, 4949.505049495048, 4970.975145124274, 4836.492168322328, 4885.413750349963, 4889.119958407486, 4889.804407823692, 4895.926561101586, 3833.5591406988133, 3842.212346468981, 3843.500344955152, 3860.285847118285, 3879.262940041383, 3723.888283351504, 3842.53889533255, 3847.5571660627265, 3848.942265866014, 3853.7687738735626, 3786.299534586097, 3809.3904975203973, 3834.923301533968, 3851.133494963639, 3862.2661694278, 3818.6372294631965, 3820.8662696805754, 3826.0, 3826.1199924017633, 3848.749831260973, 3172.7144556989983, 3206.150370151912, 3345.1469875181915, 3367.579052618423, 3386.865400090948, 4702.764861756933, 4705.882352941204, 4715.575598196145, 4717.481077081518, 4745.905081898377, 4363.0, 4367.563243675639, 4367.847125350598, 4389.758563279019, 4390.078083602447, 4760.571828451485, 4883.9011222474655, 5036.622253331015, 5095.439501654815, 5125.436202017775, 3659.323025240339, 3671.7980511071883, 3684.360459595481, 3685.281370132825, 3688.2992231475932, 5310.36275646921, 5317.441668624778, 5318.175682769177, 5323.387810401815, 5389.568834493231, 3552.378333791576, 3724.2923844470006, 3821.7515861468914, 3822.7132965027736, 3828.578856325802, 3741.7886308727384, 3749.2876353492748, 3752.4934133891575, 3764.228333191689, 3786.981065094657, 4296.613304802583, 4300.65594752419, 4306.913861722748, 4313.547077556874, 4317.784110794448, 5076.644634875597, 5106.617003724736, 5112.437631860493, 5118.61610379223, 5131.204663277198, 1234.4630085912656, 1292.959167869855, 1303.3678665847056, 1308.7317099994477, 1311.2984553263957, 808.3008197908885, 820.2781552233996, 828.5484410996022, 832.9583520823935, 841.8190089130866, 3978.462907507507, 4007.358822588372, 4010.6590939770444, 4023.4166045923175, 4041.434199212054, 4632.559906808848, 4636.721796692209, 4639.420072490939, 4648.674592778473, 4651.232546629768, 4006.1787333596544, 4050.832804449605, 4059.2693315203546, 4069.4302797608357, 4070.226656935232, 2331.2311597652006, 2474.888630011618, 2481.8955564773864, 2483.913063042785, 2493.364192130995, 4418.756968366771, 4759.762011899391, 4825.831095911626, 4995.900081998339, 5024.221245706921, 5409.161579955114, 5416.510459623635, 5427.48438898304, 5427.891442171134, 5442.863928401822, 4969.2546118081855, 4975.477574854733, 4977.303177555145, 5014.799408023711, 5015.598752099823, 5061.291419201241, 5179.974100129475, 5228.738563071907, 5235.947640523546, 5243.265942768092, 5147.819826306061, 5160.690358578498, 5163.225516172604, 5171.974140129275, 5188.351456067991, 4744.430668319824, 4949.277897156478, 4973.5523802857915, 4975.701457912537, 4975.726335051607, 3673.8714145004797, 3690.3541880170324, 3696.4085746280466, 3699.5560532736245, 3716.219593885314, 5245.0, 5253.159494480865, 5255.0, 5272.920906186334, 5298.072837253542, 5085.847424577269, 5096.23556466533, 5127.564282001045, 5154.14956532168, 5154.252633368065, 4833.202521583899, 5089.0, 5141.691498510101, 5166.3800343958965, 5172.1465958118, 5043.646944713835, 5072.666573376288, 5116.386033675983, 5116.923246151385, 5138.8972220556125, 4849.927251091307, 5190.740462976912, 5236.423993360803, 5245.449227831023, 5277.182036784305, 4981.227909674007, 5013.323201367769, 5015.699058056528, 5023.296738456546, 5035.237666816732], "value": 3797.4146627848404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6167501911153, 572.0960881806745, 584.5674201091189, 598.0670154558887, 607.2955371768746, 12429.067819913509, 13202.075854690176, 13247.072704910635, 13259.40332685029, 13270.7345853083, 11751.118666100034, 11877.584284550043, 11912.404379781019, 11921.701957451047, 12006.399680016008, 712.8609921065395, 727.0439372225533, 729.7117638532803, 729.9343059124677, 730.5543618392776, 588.0033343482799, 710.2364957670499, 738.9261073892594, 744.9553026818409, 747.805570551655, 777.0170734021439, 777.9688812447496, 778.2334400615389, 778.4861991085885, 778.6301506784289, 775.3796962430033, 775.4959276470311, 775.5385545600359, 775.6393277126135, 776.6116941529235, 456.06051533840395, 459.75632914555337, 459.78619941726924, 548.5858177076282, 563.4478211352856, 11524.711882203012, 11557.653270401901, 11563.612366515988, 11581.710457238552, 11594.47824847884, 10703.625373111903, 11156.330620162817, 11201.495932682967, 11356.091512679048, 11855.46650400734, 11306.265092769027, 11333.433328333633, 11389.658310250707, 11389.829152562717, 11489.310641361544, 3865.845366185349, 3884.2425726982965, 3906.7655940643654, 3917.2948869203533, 3922.2155568886337, 53703.462965370236, 55215.447845521834, 56607.433925660625, 62382.688086559734, 66026.66986665085, 8678.56607169639, 8938.46369217849, 9072.228860546795, 9120.407173533698, 9348.532573371303, 16242.58905629831, 16399.18004099814, 16400.589985250463, 16415.753763693556, 16583.6683266334, 6804.965975170093, 6845.110135682329, 6860.142482189726, 6860.759873404507, 6940.618265995317, 3610.151614370621, 3640.9089772755365, 3685.152414944524, 3695.4641576971726, 3761.774293542396, 2626.2121363590845, 2719.360950176707, 2721.5781553859183, 2725.591161325817, 2727.6317697111035, 482.0696056610775, 483.74361588358227, 483.84275110588493, 490.4090570862103, 497.0704782057575, 470.2147413818931, 494.110206340423, 551.1402212548437, 570.3811364669298, 584.0480017571332, 7035.155781306276, 7354.70581176747, 7704.460687751915, 7742.58622153203, 8193.0, 499.6827014845599, 512.7718165416428, 542.6038991536201, 567.8807450435372, 573.0458786121145, 3597.8380972856285, 3737.7009839213342, 3831.7126215533945, 3839.6352346527037, 3864.3430616795213, 102217.48891255645, 102435.0, 105131.0, 106899.0, 107936.46031769791, 48903.75548122237, 55422.44577554173, 84571.57714211513, 87899.1210087891, 87936.560317198, 46409.76795116003, 63934.68032659807, 79780.98437242601, 79784.20215797768, 81286.0, 7008.369246767611, 7144.535605185646, 7234.6744396501235, 7279.636018199175, 7546.471746977879, 43781.78109109434, 44140.77929610331, 44471.777641111585, 46543.06913861771, 46609.53390466052, 62057.379426206964, 68876.65561672159, 68895.0, 69078.0, 69182.65408672925, 9103.863442048241, 9379.624815007597, 9403.153716165578, 9438.480883551196, 9600.855987160337, 10197.54111064989, 10204.4387558685, 10317.74205644865, 10997.835032474359, 11232.3260604364, 9738.659146930107, 9828.26288028415, 9897.604095836086, 9904.158146557624, 10533.735951685847, 9515.619375224913, 9690.030996900536, 10643.414612196404, 11354.489047993025, 11673.0, 10682.252242342962, 10952.726181845517, 10981.176411768989, 12283.570075047688, 12294.0, 8933.28533717314, 9066.22937050358, 9590.760230994281, 9942.15491683215, 10454.790904182026, 9295.814083718153, 9775.315727899264, 10226.233032522441, 10233.897661023593, 10344.172466202835], "value": 6159.95121923646, "unit": "score"}], "name": "dromaeo_css", "value": 6166.37447286521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 119.0, 114.0, 116.0, 115.0, 113.0, 117.0, 117.0, 133.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 155.0, 195.0, 122.0, 159.0, 153.0, 125.0, 187.0, 127.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 165.0, 161.0, 162.0, 161.0, 161.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 167.0, 77.0, 78.0, 76.0, 77.0, 159.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 140.0, 84.0, 83.0, 83.0, 149.0, 83.0, 83.0, 149.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 65.0, 66.0, 65.0, 64.0, 64.0, 76.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 90.0, 82.0, 86.0, 82.0, 81.0, 81.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 131.0, 134.0, 144.0, 133.0, 141.0, 134.0, 176.0, 132.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 174.0, 176.0, 173.0, 180.0, 172.0, 177.0, 173.0, 175.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0, 69.0, 69.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1586.9999999999998, "alertThreshold": 2.0}]} 15:16:32 INFO - Return code: 0 15:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:16:32 INFO - # TBPL SUCCESS # 15:16:32 INFO - Running post-action listener: _resource_record_post_action 15:16:32 INFO - [mozharness: 2016-09-02 22:16:32.864747Z] Finished run-tests step (success) 15:16:32 INFO - Running post-run listener: _resource_record_post_run 15:16:32 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 396722176; Read time: 0; Write time: 257084 15:16:32 INFO - TinderboxPrint: CPU usage
13.1% 15:16:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:16:32 INFO - TinderboxPrint: I/O write bytes / time
396,722,176 / 257,084 15:16:32 INFO - TinderboxPrint: CPU idle
8,330.3 (86.9%) 15:16:32 INFO - TinderboxPrint: CPU user
1,206.8 (12.6%) 15:16:32 INFO - TinderboxPrint: Swap in / out
0 / 0 15:16:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113504256; Read time: 0; Write time: 92144 15:16:32 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 282316800; Read time: 0; Write time: 164916 15:16:33 INFO - Running post-run listener: _upload_blobber_files 15:16:33 INFO - Blob upload gear active. 15:16:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:33 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 15:16:33 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:16:33 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:16:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:37 INFO - (blobuploader) - INFO - Done attempting. 15:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:38 INFO - (blobuploader) - INFO - Done attempting. 15:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:39 INFO - (blobuploader) - INFO - Done attempting. 15:16:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:39 INFO - Return code: 0 15:16:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fba66aeabd42a2feb619778f3ed3986ca839aee31a2e5bbeb7d1f24ab980cbe8b8d9dfa3cad3853115497d238921ce7709f6b97889c707f97d5e4b092ad2969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb655600a7e779884878c7aefc7b8e5cbbb324c8712f06a4ed1c4d882947b2dd22cbd13f641b8ddc6745e67c21b1a5063a32f7d28b7c2060250ac1df13a303f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ac61437045fd4d58d4ab7f86b5099fccb0dfd057ca422cfefdf0f64b429138f9873b4f7b358d3aea95442dd6f05694fea9d9342d23349aa5fd859283e87f95e"} 15:16:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:39 INFO - Contents: 15:16:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fba66aeabd42a2feb619778f3ed3986ca839aee31a2e5bbeb7d1f24ab980cbe8b8d9dfa3cad3853115497d238921ce7709f6b97889c707f97d5e4b092ad2969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb655600a7e779884878c7aefc7b8e5cbbb324c8712f06a4ed1c4d882947b2dd22cbd13f641b8ddc6745e67c21b1a5063a32f7d28b7c2060250ac1df13a303f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ac61437045fd4d58d4ab7f86b5099fccb0dfd057ca422cfefdf0f64b429138f9873b4f7b358d3aea95442dd6f05694fea9d9342d23349aa5fd859283e87f95e"} 15:16:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:39 INFO - Copying logs to upload dir... 15:16:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.042698 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-02 15:16:37.963946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 15:16:37.967490) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fba66aeabd42a2feb619778f3ed3986ca839aee31a2e5bbeb7d1f24ab980cbe8b8d9dfa3cad3853115497d238921ce7709f6b97889c707f97d5e4b092ad2969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb655600a7e779884878c7aefc7b8e5cbbb324c8712f06a4ed1c4d882947b2dd22cbd13f641b8ddc6745e67c21b1a5063a32f7d28b7c2060250ac1df13a303f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ac61437045fd4d58d4ab7f86b5099fccb0dfd057ca422cfefdf0f64b429138f9873b4f7b358d3aea95442dd6f05694fea9d9342d23349aa5fd859283e87f95e"} build_url:https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/f3B0fny5RgOVoMPOWwa4SQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fba66aeabd42a2feb619778f3ed3986ca839aee31a2e5bbeb7d1f24ab980cbe8b8d9dfa3cad3853115497d238921ce7709f6b97889c707f97d5e4b092ad2969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb655600a7e779884878c7aefc7b8e5cbbb324c8712f06a4ed1c4d882947b2dd22cbd13f641b8ddc6745e67c21b1a5063a32f7d28b7c2060250ac1df13a303f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ac61437045fd4d58d4ab7f86b5099fccb0dfd057ca422cfefdf0f64b429138f9873b4f7b358d3aea95442dd6f05694fea9d9342d23349aa5fd859283e87f95e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 15:16:37.993175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:16:37.993575) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1472853313.676083-2045971329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:16:38.076049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 15:16:38.076411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 15:16:38.076727) ========= ========= Total master_lag: 0.16 =========